builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1466640564.11 results: success (0) buildid: 20160622143004 builduid: 0b4bde6c3f03478e809a48325d9716e8 revision: 882dd3714959ace05ad400f14a1c7839f4482006 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 17:09:24.112580) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 17:09:24.113024) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 17:09:24.113305) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 17:09:24.144327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:09:24.144618) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 17:09:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-06-22 17:09:25 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116111 ========= master_lag: 0.25 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:09:24.508802) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:09:24.509118) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017804 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:09:24.558938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:09:24.559259) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 882dd3714959ace05ad400f14a1c7839f4482006 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 882dd3714959ace05ad400f14a1c7839f4482006 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 17:09:25,561 truncating revision to first 12 chars 2016-06-22 17:09:25,562 Setting DEBUG logging. 2016-06-22 17:09:25,562 attempt 1/10 2016-06-22 17:09:25,562 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/882dd3714959?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 17:09:25,880 unpacking tar archive at: fx-team-882dd3714959/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656175 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:09:25.229352) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 17:09:25.229636) ========= script_repo_revision: 882dd3714959ace05ad400f14a1c7839f4482006 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 17:09:25.230045) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 17:09:25.230326) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 17:09:25.241066) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-22 17:09:25.241336) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:09:26 INFO - MultiFileLogger online at 20160622 17:09:26 in /builds/slave/test 17:09:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:09:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:09:26 INFO - {'append_to_log': False, 17:09:26 INFO - 'base_work_dir': '/builds/slave/test', 17:09:26 INFO - 'blob_upload_branch': 'Fx-Team', 17:09:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:09:26 INFO - 'branch': 'Fx-Team', 17:09:26 INFO - 'buildbot_json_path': 'buildprops.json', 17:09:26 INFO - 'config_files': ('talos/linux_config.py',), 17:09:26 INFO - 'default_actions': ('clobber', 17:09:26 INFO - 'read-buildbot-config', 17:09:26 INFO - 'download-and-extract', 17:09:26 INFO - 'populate-webroot', 17:09:26 INFO - 'create-virtualenv', 17:09:26 INFO - 'install', 17:09:26 INFO - 'run-tests'), 17:09:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:09:26 INFO - 'download_minidump_stackwalk': True, 17:09:26 INFO - 'download_symbols': 'ondemand', 17:09:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:09:26 INFO - 'tooltool.py': '/tools/tooltool.py', 17:09:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:09:26 INFO - '/tools/misc-python/virtualenv.py')}, 17:09:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:09:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:09:26 INFO - 'installer_path': 'installer.exe', 17:09:26 INFO - 'log_level': 'info', 17:09:26 INFO - 'log_name': 'talos', 17:09:26 INFO - 'log_to_console': True, 17:09:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:09:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:09:26 INFO - 'opt_config_files': (), 17:09:26 INFO - 'pip_index': False, 17:09:26 INFO - 'sps_profile': False, 17:09:26 INFO - 'sps_profile_interval': 0, 17:09:26 INFO - 'suite': 'dromaeojs-e10s', 17:09:26 INFO - 'system_bits': '32', 17:09:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:09:26 INFO - 'title': 'talos-linux64-ix-063', 17:09:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:09:26 INFO - 'use_talos_json': True, 17:09:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:09:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:09:26 INFO - 'work_dir': 'build'} 17:09:26 INFO - ##### 17:09:26 INFO - ##### Running clobber step. 17:09:26 INFO - ##### 17:09:26 INFO - Running pre-action listener: _resource_record_pre_action 17:09:26 INFO - Running main action method: clobber 17:09:26 INFO - rmtree: /builds/slave/test/build 17:09:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:09:26 INFO - Running post-action listener: _resource_record_post_action 17:09:26 INFO - ##### 17:09:26 INFO - ##### Finished clobber step (success) 17:09:26 INFO - ##### 17:09:26 INFO - ##### 17:09:26 INFO - ##### Running read-buildbot-config step. 17:09:26 INFO - ##### 17:09:26 INFO - Running pre-action listener: _resource_record_pre_action 17:09:26 INFO - Running main action method: read_buildbot_config 17:09:26 INFO - Using buildbot properties: 17:09:26 INFO - { 17:09:26 INFO - "project": "", 17:09:26 INFO - "product": "firefox", 17:09:26 INFO - "script_repo_revision": "production", 17:09:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:09:26 INFO - "repository": "", 17:09:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:09:26 INFO - "buildid": "20160622143004", 17:09:26 INFO - "pgo_build": "True", 17:09:26 INFO - "basedir": "/builds/slave/test", 17:09:26 INFO - "buildnumber": 494, 17:09:26 INFO - "slavename": "talos-linux64-ix-063", 17:09:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:09:26 INFO - "platform": "ubuntu64_hw", 17:09:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:09:26 INFO - "branch": "fx-team", 17:09:26 INFO - "repo_path": "integration/fx-team", 17:09:26 INFO - "revision": "882dd3714959ace05ad400f14a1c7839f4482006", 17:09:26 INFO - "stage_platform": "linux64-pgo", 17:09:26 INFO - "builduid": "0b4bde6c3f03478e809a48325d9716e8", 17:09:26 INFO - "slavebuilddir": "test" 17:09:26 INFO - } 17:09:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:09:26 INFO - Running post-action listener: _resource_record_post_action 17:09:26 INFO - ##### 17:09:26 INFO - ##### Finished read-buildbot-config step (success) 17:09:26 INFO - ##### 17:09:26 INFO - ##### 17:09:26 INFO - ##### Running download-and-extract step. 17:09:26 INFO - ##### 17:09:26 INFO - Running pre-action listener: _resource_record_pre_action 17:09:26 INFO - Running main action method: download_and_extract 17:09:26 INFO - mkdir: /builds/slave/test/build/tests 17:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:26 INFO - https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:09:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:09:28 INFO - Downloaded 1361 bytes. 17:09:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:28 INFO - Using the following test package requirements: 17:09:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:09:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:09:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:28 INFO - u'jsshell-linux-x86_64.zip'], 17:09:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:09:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:09:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:09:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:09:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:09:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:28 INFO - https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:09:29 INFO - Downloaded 24269679 bytes. 17:09:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:09:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:09:31 INFO - Return code: 0 17:09:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:31 INFO - https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:09:38 INFO - Downloaded 24269679 bytes. 17:09:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:09:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:09:40 INFO - Return code: 0 17:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:40 INFO - https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:09:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:09:41 INFO - Downloaded 14405384 bytes. 17:09:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:09:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:09:41 INFO - Return code: 0 17:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:41 INFO - https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:09:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:09:43 INFO - Downloaded 60180028 bytes. 17:09:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:43 INFO - mkdir: /builds/slave/test/properties 17:09:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:09:43 INFO - Writing to file /builds/slave/test/properties/build_url 17:09:43 INFO - Contents: 17:09:43 INFO - build_url:https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:43 INFO - Running post-action listener: _resource_record_post_action 17:09:43 INFO - Running post-action listener: set_extra_try_arguments 17:09:43 INFO - ##### 17:09:43 INFO - ##### Finished download-and-extract step (success) 17:09:43 INFO - ##### 17:09:43 INFO - ##### 17:09:43 INFO - ##### Running populate-webroot step. 17:09:43 INFO - ##### 17:09:43 INFO - Running pre-action listener: _resource_record_pre_action 17:09:43 INFO - Running main action method: populate_webroot 17:09:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:09:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:09:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:09:44 INFO - '--tppagecycles', 17:09:44 INFO - '7'], 17:09:44 INFO - 'tests': ['tsvgm']}}, 17:09:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:09:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:09:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:09:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:09:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:09:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:09:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:44 INFO - 'talos_options': ['--disable-e10s'], 17:09:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:44 INFO - 'talos_options': ['--disable-e10s'], 17:09:44 INFO - 'tests': ['damp', 'tps']}, 17:09:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:44 INFO - 'tests': ['damp', 'tps']}, 17:09:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:09:44 INFO - 'tests': ['dromaeo_dom']}, 17:09:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:09:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:09:44 INFO - 'tests': ['basic_compositor_video']}, 17:09:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:09:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:09:44 INFO - 'tests': ['a11yr', 17:09:44 INFO - 'ts_paint', 17:09:44 INFO - 'tpaint', 17:09:44 INFO - 'sessionrestore', 17:09:44 INFO - 'sessionrestore_no_auto_restore', 17:09:44 INFO - 'tabpaint']}, 17:09:44 INFO - 'other-e10s': {'tests': ['a11yr', 17:09:44 INFO - 'ts_paint', 17:09:44 INFO - 'tpaint', 17:09:44 INFO - 'sessionrestore', 17:09:44 INFO - 'sessionrestore_no_auto_restore', 17:09:44 INFO - 'tabpaint']}, 17:09:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:09:44 INFO - 'ts_paint', 17:09:44 INFO - 'tpaint', 17:09:44 INFO - 'sessionrestore', 17:09:44 INFO - 'sessionrestore_no_auto_restore', 17:09:44 INFO - 'tabpaint']}, 17:09:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:09:44 INFO - 'ts_paint', 17:09:44 INFO - 'tpaint', 17:09:44 INFO - 'sessionrestore', 17:09:44 INFO - 'sessionrestore_no_auto_restore', 17:09:44 INFO - 'tabpaint']}, 17:09:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:09:44 INFO - 'tests': ['a11yr', 17:09:44 INFO - 'ts_paint', 17:09:44 INFO - 'tpaint', 17:09:44 INFO - 'sessionrestore', 17:09:44 INFO - 'sessionrestore_no_auto_restore', 17:09:44 INFO - 'tabpaint']}, 17:09:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:09:44 INFO - 'tests': ['a11yr', 17:09:44 INFO - 'ts_paint', 17:09:44 INFO - 'tpaint', 17:09:44 INFO - 'sessionrestore', 17:09:44 INFO - 'sessionrestore_no_auto_restore', 17:09:44 INFO - 'tabpaint']}, 17:09:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:09:44 INFO - 'tests': ['tsvgx', 17:09:44 INFO - 'tsvgr_opacity', 17:09:44 INFO - 'tart', 17:09:44 INFO - 'tscrollx', 17:09:44 INFO - 'cart']}, 17:09:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:09:44 INFO - 'tsvgr_opacity', 17:09:44 INFO - 'tart', 17:09:44 INFO - 'tscrollx', 17:09:44 INFO - 'cart']}, 17:09:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:44 INFO - 'talos_options': ['--disable-e10s'], 17:09:44 INFO - 'tests': ['tp5o']}, 17:09:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:44 INFO - 'tests': ['tp5o']}, 17:09:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:44 INFO - 'talos_options': ['--disable-e10s', 17:09:44 INFO - '--xperf_path', 17:09:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:44 INFO - 'tests': ['tp5n']}, 17:09:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:44 INFO - 'talos_options': ['--xperf_path', 17:09:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:44 INFO - 'tests': ['tp5n']}}, 17:09:44 INFO - 'talos.zip': {'path': '', 17:09:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:09:44 INFO - Running post-action listener: _resource_record_post_action 17:09:44 INFO - ##### 17:09:44 INFO - ##### Finished populate-webroot step (success) 17:09:44 INFO - ##### 17:09:44 INFO - ##### 17:09:44 INFO - ##### Running create-virtualenv step. 17:09:44 INFO - ##### 17:09:44 INFO - Running pre-action listener: _resource_record_pre_action 17:09:44 INFO - Running main action method: create_virtualenv 17:09:44 INFO - Creating virtualenv /builds/slave/test/build/venv 17:09:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:09:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:09:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:09:44 INFO - Using real prefix '/usr' 17:09:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:09:44 INFO - Installing distribute.............................................................................................................................................................................................done. 17:09:46 INFO - Installing pip.................done. 17:09:46 INFO - Return code: 0 17:09:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43eb374f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:09:46 INFO - Using env: {'DISPLAY': ':0', 17:09:46 INFO - 'HOME': '/home/cltbld', 17:09:46 INFO - 'LANG': 'en_US.UTF-8', 17:09:46 INFO - 'LANGUAGE': 'en_US:en', 17:09:46 INFO - 'LOGNAME': 'cltbld', 17:09:46 INFO - 'MAIL': '/var/mail/cltbld', 17:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:46 INFO - 'MOZ_NO_REMOTE': '1', 17:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:46 INFO - 'NO_EM_RESTART': '1', 17:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:46 INFO - 'PWD': '/builds/slave/test', 17:09:46 INFO - 'SHELL': '/bin/bash', 17:09:46 INFO - 'SHLVL': '1', 17:09:46 INFO - 'TERM': 'linux', 17:09:46 INFO - 'TMOUT': '86400', 17:09:46 INFO - 'USER': 'cltbld', 17:09:46 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 17:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:46 INFO - '_': '/tools/buildbot/bin/python'} 17:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:09:46 INFO - Cleaning up... 17:09:46 INFO - Return code: 0 17:09:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43eb374f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:09:46 INFO - Using env: {'DISPLAY': ':0', 17:09:46 INFO - 'HOME': '/home/cltbld', 17:09:46 INFO - 'LANG': 'en_US.UTF-8', 17:09:46 INFO - 'LANGUAGE': 'en_US:en', 17:09:46 INFO - 'LOGNAME': 'cltbld', 17:09:46 INFO - 'MAIL': '/var/mail/cltbld', 17:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:46 INFO - 'MOZ_NO_REMOTE': '1', 17:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:46 INFO - 'NO_EM_RESTART': '1', 17:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:46 INFO - 'PWD': '/builds/slave/test', 17:09:46 INFO - 'SHELL': '/bin/bash', 17:09:46 INFO - 'SHLVL': '1', 17:09:46 INFO - 'TERM': 'linux', 17:09:46 INFO - 'TMOUT': '86400', 17:09:46 INFO - 'USER': 'cltbld', 17:09:46 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 17:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:46 INFO - '_': '/tools/buildbot/bin/python'} 17:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:47 INFO - Downloading/unpacking psutil>=3.1.1 17:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:09:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:49 INFO - Installing collected packages: psutil 17:09:49 INFO - Running setup.py install for psutil 17:09:49 INFO - building 'psutil._psutil_linux' extension 17:09:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:09:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:09:49 INFO - building 'psutil._psutil_posix' extension 17:09:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:09:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:09:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:49 INFO - Successfully installed psutil 17:09:49 INFO - Cleaning up... 17:09:49 INFO - Return code: 0 17:09:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43eb374f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:09:49 INFO - Using env: {'DISPLAY': ':0', 17:09:49 INFO - 'HOME': '/home/cltbld', 17:09:49 INFO - 'LANG': 'en_US.UTF-8', 17:09:49 INFO - 'LANGUAGE': 'en_US:en', 17:09:49 INFO - 'LOGNAME': 'cltbld', 17:09:49 INFO - 'MAIL': '/var/mail/cltbld', 17:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:49 INFO - 'MOZ_NO_REMOTE': '1', 17:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:49 INFO - 'NO_EM_RESTART': '1', 17:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:49 INFO - 'PWD': '/builds/slave/test', 17:09:49 INFO - 'SHELL': '/bin/bash', 17:09:49 INFO - 'SHLVL': '1', 17:09:49 INFO - 'TERM': 'linux', 17:09:49 INFO - 'TMOUT': '86400', 17:09:49 INFO - 'USER': 'cltbld', 17:09:49 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 17:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:49 INFO - '_': '/tools/buildbot/bin/python'} 17:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:09:51 INFO - Installing collected packages: mozsystemmonitor 17:09:51 INFO - Running setup.py install for mozsystemmonitor 17:09:51 INFO - Successfully installed mozsystemmonitor 17:09:51 INFO - Cleaning up... 17:09:51 INFO - Return code: 0 17:09:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43eb374f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:09:51 INFO - Using env: {'DISPLAY': ':0', 17:09:51 INFO - 'HOME': '/home/cltbld', 17:09:51 INFO - 'LANG': 'en_US.UTF-8', 17:09:51 INFO - 'LANGUAGE': 'en_US:en', 17:09:51 INFO - 'LOGNAME': 'cltbld', 17:09:51 INFO - 'MAIL': '/var/mail/cltbld', 17:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:51 INFO - 'MOZ_NO_REMOTE': '1', 17:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:51 INFO - 'NO_EM_RESTART': '1', 17:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:51 INFO - 'PWD': '/builds/slave/test', 17:09:51 INFO - 'SHELL': '/bin/bash', 17:09:51 INFO - 'SHLVL': '1', 17:09:51 INFO - 'TERM': 'linux', 17:09:51 INFO - 'TMOUT': '86400', 17:09:51 INFO - 'USER': 'cltbld', 17:09:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 17:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:51 INFO - '_': '/tools/buildbot/bin/python'} 17:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:52 INFO - Downloading/unpacking jsonschema==2.5.1 17:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:09:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:54 INFO - Downloading functools32-3.2.3-2.tar.gz 17:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:09:54 INFO - warning: no files found matching '*.txt' 17:09:54 INFO - no previously-included directories found matching 'build' 17:09:54 INFO - no previously-included directories found matching 'dist' 17:09:54 INFO - no previously-included directories found matching '.git*' 17:09:54 INFO - Installing collected packages: jsonschema, functools32 17:09:54 INFO - Running setup.py install for functools32 17:09:54 INFO - warning: no files found matching '*.txt' 17:09:54 INFO - no previously-included directories found matching 'build' 17:09:54 INFO - no previously-included directories found matching 'dist' 17:09:54 INFO - no previously-included directories found matching '.git*' 17:09:54 INFO - Successfully installed jsonschema functools32 17:09:54 INFO - Cleaning up... 17:09:54 INFO - Return code: 0 17:09:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43eb374f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:09:54 INFO - Using env: {'DISPLAY': ':0', 17:09:54 INFO - 'HOME': '/home/cltbld', 17:09:54 INFO - 'LANG': 'en_US.UTF-8', 17:09:54 INFO - 'LANGUAGE': 'en_US:en', 17:09:54 INFO - 'LOGNAME': 'cltbld', 17:09:54 INFO - 'MAIL': '/var/mail/cltbld', 17:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:54 INFO - 'MOZ_NO_REMOTE': '1', 17:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:54 INFO - 'NO_EM_RESTART': '1', 17:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:54 INFO - 'PWD': '/builds/slave/test', 17:09:54 INFO - 'SHELL': '/bin/bash', 17:09:54 INFO - 'SHLVL': '1', 17:09:54 INFO - 'TERM': 'linux', 17:09:54 INFO - 'TMOUT': '86400', 17:09:54 INFO - 'USER': 'cltbld', 17:09:54 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 17:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:54 INFO - '_': '/tools/buildbot/bin/python'} 17:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:54 INFO - Downloading/unpacking blobuploader==1.2.4 17:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:56 INFO - Downloading blobuploader-1.2.4.tar.gz 17:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:09:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:09:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:57 INFO - Downloading docopt-0.6.1.tar.gz 17:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:09:57 INFO - Installing collected packages: blobuploader, requests, docopt 17:09:57 INFO - Running setup.py install for blobuploader 17:09:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:09:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:09:57 INFO - Running setup.py install for requests 17:09:57 INFO - Running setup.py install for docopt 17:09:57 INFO - Successfully installed blobuploader requests docopt 17:09:57 INFO - Cleaning up... 17:09:57 INFO - Return code: 0 17:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43eb374f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:09:57 INFO - Using env: {'DISPLAY': ':0', 17:09:57 INFO - 'HOME': '/home/cltbld', 17:09:57 INFO - 'LANG': 'en_US.UTF-8', 17:09:57 INFO - 'LANGUAGE': 'en_US:en', 17:09:57 INFO - 'LOGNAME': 'cltbld', 17:09:57 INFO - 'MAIL': '/var/mail/cltbld', 17:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:57 INFO - 'MOZ_NO_REMOTE': '1', 17:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:57 INFO - 'NO_EM_RESTART': '1', 17:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:57 INFO - 'PWD': '/builds/slave/test', 17:09:57 INFO - 'SHELL': '/bin/bash', 17:09:57 INFO - 'SHLVL': '1', 17:09:57 INFO - 'TERM': 'linux', 17:09:57 INFO - 'TMOUT': '86400', 17:09:57 INFO - 'USER': 'cltbld', 17:09:57 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 17:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:57 INFO - '_': '/tools/buildbot/bin/python'} 17:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:58 INFO - Running setup.py (path:/tmp/pip-deEV1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:58 INFO - Running setup.py (path:/tmp/pip-8PAivD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:58 INFO - Running setup.py (path:/tmp/pip-YPEQbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:58 INFO - Running setup.py (path:/tmp/pip-m0kYYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:58 INFO - Running setup.py (path:/tmp/pip-vVP2qA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:58 INFO - Running setup.py (path:/tmp/pip-h3qyOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:58 INFO - Running setup.py (path:/tmp/pip-w9UEdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:58 INFO - Running setup.py (path:/tmp/pip-bHx_V9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:58 INFO - Running setup.py (path:/tmp/pip-uetp4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:58 INFO - Running setup.py (path:/tmp/pip-c7xRqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:58 INFO - Running setup.py (path:/tmp/pip-HzNwfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:58 INFO - Running setup.py (path:/tmp/pip-ZlI8OO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:59 INFO - Running setup.py (path:/tmp/pip-obmM0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:59 INFO - Running setup.py (path:/tmp/pip-WtGfAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:59 INFO - Running setup.py (path:/tmp/pip-hv3NH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:59 INFO - Running setup.py (path:/tmp/pip-enCdr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:59 INFO - Running setup.py (path:/tmp/pip-HRqtsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:09:59 INFO - Running setup.py install for manifestparser 17:09:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:09:59 INFO - Running setup.py install for mozcrash 17:09:59 INFO - Running setup.py install for mozdebug 17:09:59 INFO - Running setup.py install for mozdevice 17:09:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:09:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:09:59 INFO - Running setup.py install for mozfile 17:09:59 INFO - Running setup.py install for mozhttpd 17:09:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:09:59 INFO - Running setup.py install for mozinfo 17:10:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:10:00 INFO - Running setup.py install for mozInstall 17:10:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:10:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:10:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:10:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:10:00 INFO - Running setup.py install for mozleak 17:10:00 INFO - Running setup.py install for mozlog 17:10:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:10:00 INFO - Running setup.py install for moznetwork 17:10:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:10:00 INFO - Running setup.py install for mozprocess 17:10:00 INFO - Running setup.py install for mozprofile 17:10:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:10:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:10:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:10:00 INFO - Running setup.py install for mozrunner 17:10:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:10:00 INFO - Running setup.py install for mozscreenshot 17:10:00 INFO - Running setup.py install for moztest 17:10:01 INFO - Running setup.py install for mozversion 17:10:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:10:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:10:01 INFO - Cleaning up... 17:10:01 INFO - Return code: 0 17:10:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43eb374f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:10:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:10:01 INFO - Using env: {'DISPLAY': ':0', 17:10:01 INFO - 'HOME': '/home/cltbld', 17:10:01 INFO - 'LANG': 'en_US.UTF-8', 17:10:01 INFO - 'LANGUAGE': 'en_US:en', 17:10:01 INFO - 'LOGNAME': 'cltbld', 17:10:01 INFO - 'MAIL': '/var/mail/cltbld', 17:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:01 INFO - 'MOZ_NO_REMOTE': '1', 17:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:01 INFO - 'NO_EM_RESTART': '1', 17:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:01 INFO - 'PWD': '/builds/slave/test', 17:10:01 INFO - 'SHELL': '/bin/bash', 17:10:01 INFO - 'SHLVL': '1', 17:10:01 INFO - 'TERM': 'linux', 17:10:01 INFO - 'TMOUT': '86400', 17:10:01 INFO - 'USER': 'cltbld', 17:10:01 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 17:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:01 INFO - '_': '/tools/buildbot/bin/python'} 17:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:01 INFO - Running setup.py (path:/tmp/pip-LVL0uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:01 INFO - Running setup.py (path:/tmp/pip-C4X0N9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:01 INFO - Running setup.py (path:/tmp/pip-2I_VSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:01 INFO - Running setup.py (path:/tmp/pip-39n0Ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:01 INFO - Running setup.py (path:/tmp/pip-f7dnHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:01 INFO - Running setup.py (path:/tmp/pip-1muNrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:01 INFO - Running setup.py (path:/tmp/pip-H0WOJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:01 INFO - Running setup.py (path:/tmp/pip-4SZmcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:01 INFO - Running setup.py (path:/tmp/pip-wK9A3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:02 INFO - Running setup.py (path:/tmp/pip-upox2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:02 INFO - Running setup.py (path:/tmp/pip-sKrN_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:02 INFO - Running setup.py (path:/tmp/pip-fdAMRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:02 INFO - Running setup.py (path:/tmp/pip-kROPx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:02 INFO - Running setup.py (path:/tmp/pip-aWGpCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:02 INFO - Running setup.py (path:/tmp/pip-GpVOxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:02 INFO - Running setup.py (path:/tmp/pip-zcUZzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:02 INFO - Running setup.py (path:/tmp/pip-mqCRGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:10:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:04 INFO - Downloading blessings-1.6.tar.gz 17:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:10:04 INFO - Installing collected packages: blessings 17:10:04 INFO - Running setup.py install for blessings 17:10:04 INFO - Successfully installed blessings 17:10:04 INFO - Cleaning up... 17:10:04 INFO - Return code: 0 17:10:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:10:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:05 INFO - Reading from file tmpfile_stdout 17:10:05 INFO - Current package versions: 17:10:05 INFO - argparse == 1.2.1 17:10:05 INFO - blessings == 1.6 17:10:05 INFO - blobuploader == 1.2.4 17:10:05 INFO - docopt == 0.6.1 17:10:05 INFO - functools32 == 3.2.3-2 17:10:05 INFO - jsonschema == 2.5.1 17:10:05 INFO - manifestparser == 1.1 17:10:05 INFO - mozInstall == 1.12 17:10:05 INFO - mozcrash == 0.17 17:10:05 INFO - mozdebug == 0.1 17:10:05 INFO - mozdevice == 0.48 17:10:05 INFO - mozfile == 1.2 17:10:05 INFO - mozhttpd == 0.7 17:10:05 INFO - mozinfo == 0.9 17:10:05 INFO - mozleak == 0.1 17:10:05 INFO - mozlog == 3.2 17:10:05 INFO - moznetwork == 0.27 17:10:05 INFO - mozprocess == 0.22 17:10:05 INFO - mozprofile == 0.28 17:10:05 INFO - mozrunner == 6.11 17:10:05 INFO - mozscreenshot == 0.1 17:10:05 INFO - mozsystemmonitor == 0.3 17:10:05 INFO - moztest == 0.7 17:10:05 INFO - mozversion == 1.4 17:10:05 INFO - psutil == 3.1.1 17:10:05 INFO - requests == 1.2.3 17:10:05 INFO - wsgiref == 0.1.2 17:10:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43eb374f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:10:05 INFO - Using env: {'DISPLAY': ':0', 17:10:05 INFO - 'HOME': '/home/cltbld', 17:10:05 INFO - 'LANG': 'en_US.UTF-8', 17:10:05 INFO - 'LANGUAGE': 'en_US:en', 17:10:05 INFO - 'LOGNAME': 'cltbld', 17:10:05 INFO - 'MAIL': '/var/mail/cltbld', 17:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:05 INFO - 'MOZ_NO_REMOTE': '1', 17:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:05 INFO - 'NO_EM_RESTART': '1', 17:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:05 INFO - 'PWD': '/builds/slave/test', 17:10:05 INFO - 'SHELL': '/bin/bash', 17:10:05 INFO - 'SHLVL': '1', 17:10:05 INFO - 'TERM': 'linux', 17:10:05 INFO - 'TMOUT': '86400', 17:10:05 INFO - 'USER': 'cltbld', 17:10:05 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 17:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:05 INFO - '_': '/tools/buildbot/bin/python'} 17:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:10:05 INFO - Cleaning up... 17:10:05 INFO - Return code: 0 17:10:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43eb374f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:10:05 INFO - Using env: {'DISPLAY': ':0', 17:10:05 INFO - 'HOME': '/home/cltbld', 17:10:05 INFO - 'LANG': 'en_US.UTF-8', 17:10:05 INFO - 'LANGUAGE': 'en_US:en', 17:10:05 INFO - 'LOGNAME': 'cltbld', 17:10:05 INFO - 'MAIL': '/var/mail/cltbld', 17:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:05 INFO - 'MOZ_NO_REMOTE': '1', 17:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:05 INFO - 'NO_EM_RESTART': '1', 17:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:05 INFO - 'PWD': '/builds/slave/test', 17:10:05 INFO - 'SHELL': '/bin/bash', 17:10:05 INFO - 'SHLVL': '1', 17:10:05 INFO - 'TERM': 'linux', 17:10:05 INFO - 'TMOUT': '86400', 17:10:05 INFO - 'USER': 'cltbld', 17:10:05 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 17:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:05 INFO - '_': '/tools/buildbot/bin/python'} 17:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:10:05 INFO - Cleaning up... 17:10:05 INFO - Return code: 0 17:10:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43eb374f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:10:05 INFO - Using env: {'DISPLAY': ':0', 17:10:05 INFO - 'HOME': '/home/cltbld', 17:10:05 INFO - 'LANG': 'en_US.UTF-8', 17:10:05 INFO - 'LANGUAGE': 'en_US:en', 17:10:05 INFO - 'LOGNAME': 'cltbld', 17:10:05 INFO - 'MAIL': '/var/mail/cltbld', 17:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:05 INFO - 'MOZ_NO_REMOTE': '1', 17:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:05 INFO - 'NO_EM_RESTART': '1', 17:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:05 INFO - 'PWD': '/builds/slave/test', 17:10:05 INFO - 'SHELL': '/bin/bash', 17:10:05 INFO - 'SHLVL': '1', 17:10:05 INFO - 'TERM': 'linux', 17:10:05 INFO - 'TMOUT': '86400', 17:10:05 INFO - 'USER': 'cltbld', 17:10:05 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 17:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:05 INFO - '_': '/tools/buildbot/bin/python'} 17:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:06 INFO - Downloading/unpacking flake8 17:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:10:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:10:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:10:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:08 INFO - no previously-included directories found matching 'docs/_build' 17:10:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:10:08 INFO - Running setup.py install for pep8 17:10:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:08 INFO - no previously-included directories found matching 'docs/_build' 17:10:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:10:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:10:08 INFO - Cleaning up... 17:10:08 INFO - Return code: 0 17:10:08 INFO - Running post-action listener: _resource_record_post_action 17:10:08 INFO - Running post-action listener: _start_resource_monitoring 17:10:08 INFO - Starting resource monitoring. 17:10:08 INFO - ##### 17:10:08 INFO - ##### Finished create-virtualenv step (success) 17:10:08 INFO - ##### 17:10:08 INFO - ##### 17:10:08 INFO - ##### Running install step. 17:10:08 INFO - ##### 17:10:08 INFO - Running pre-action listener: _resource_record_pre_action 17:10:08 INFO - Running main action method: install 17:10:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:09 INFO - Reading from file tmpfile_stdout 17:10:09 INFO - Detecting whether we're running mozinstall >=1.0... 17:10:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:10:09 INFO - Reading from file tmpfile_stdout 17:10:09 INFO - Output received: 17:10:09 INFO - Usage: mozinstall [options] installer 17:10:09 INFO - Options: 17:10:09 INFO - -h, --help show this help message and exit 17:10:09 INFO - -d DEST, --destination=DEST 17:10:09 INFO - Directory to install application into. [default: 17:10:09 INFO - "/builds/slave/test"] 17:10:09 INFO - --app=APP Application being installed. [default: firefox] 17:10:09 INFO - mkdir: /builds/slave/test/build/application 17:10:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:10:31 INFO - Reading from file tmpfile_stdout 17:10:33 INFO - Output received: 17:10:33 INFO - /builds/slave/test/build/application/firefox/firefox 17:10:33 INFO - Running post-action listener: _resource_record_post_action 17:10:33 INFO - ##### 17:10:33 INFO - ##### Finished install step (success) 17:10:33 INFO - ##### 17:10:33 INFO - ##### 17:10:33 INFO - ##### Running run-tests step. 17:10:33 INFO - ##### 17:10:33 INFO - Running pre-action listener: _resource_record_pre_action 17:10:33 INFO - Running main action method: run_tests 17:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:10:33 INFO - Python 2.7.3 17:10:33 INFO - Return code: 0 17:10:33 INFO - grabbing minidump binary from tooltool 17:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aa1c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ab550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:10:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:10:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:10:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:10:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:10:33 INFO - Return code: 0 17:10:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:10:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:10:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:10:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:10:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:10:34 INFO - Return code: 0 17:10:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:10:34 INFO - Using env: {'DISPLAY': ':0', 17:10:34 INFO - 'HOME': '/home/cltbld', 17:10:34 INFO - 'LANG': 'en_US.UTF-8', 17:10:34 INFO - 'LANGUAGE': 'en_US:en', 17:10:34 INFO - 'LOGNAME': 'cltbld', 17:10:34 INFO - 'MAIL': '/var/mail/cltbld', 17:10:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:10:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:34 INFO - 'MOZ_NO_REMOTE': '1', 17:10:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:34 INFO - 'NO_EM_RESTART': '1', 17:10:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:34 INFO - 'PWD': '/builds/slave/test', 17:10:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:10:34 INFO - 'SHELL': '/bin/bash', 17:10:34 INFO - 'SHLVL': '1', 17:10:34 INFO - 'TERM': 'linux', 17:10:34 INFO - 'TMOUT': '86400', 17:10:34 INFO - 'USER': 'cltbld', 17:10:34 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790', 17:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:34 INFO - '_': '/tools/buildbot/bin/python'} 17:10:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:10:34 INFO - mozversion application_buildid: 20160622143004 17:10:34 INFO - mozversion application_changeset: 882dd3714959ace05ad400f14a1c7839f4482006 17:10:34 INFO - mozversion application_display_name: Nightly 17:10:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:10:34 INFO - mozversion application_name: Firefox 17:10:34 INFO - mozversion application_remotingname: firefox 17:10:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:10:34 INFO - mozversion application_vendor: Mozilla 17:10:34 INFO - mozversion application_version: 50.0a1 17:10:34 INFO - mozversion platform_buildid: 20160622143004 17:10:34 INFO - mozversion platform_changeset: 882dd3714959ace05ad400f14a1c7839f4482006 17:10:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:10:34 INFO - mozversion platform_version: 50.0a1 17:10:34 INFO - using testdate: 1466640634 17:10:34 INFO - actual date: 1466640634 17:10:34 INFO - starting webserver on 'localhost:49921' 17:10:34 INFO - SUITE-START | Running 2 tests 17:10:34 INFO - TEST-START | dromaeo_css 17:10:34 INFO - operating with platform_type : linux_ 17:10:34 INFO - Initialising browser for dromaeo_css test... 17:10:34 INFO - TEST-INFO | started process 27840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSHVqgR/profile http://localhost:49921/getInfo.html) 17:10:41 INFO - PROCESS | 27840 | __metrics Screen width/height:1600/1200 17:10:41 INFO - PROCESS | 27840 | colorDepth:24 17:10:41 INFO - PROCESS | 27840 | Browser inner width/height: 1024/697 17:10:41 INFO - PROCESS | 27840 | __metrics 17:10:43 ERROR - PROCESS | 27840 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 17:10:44 INFO - TEST-INFO | 27840: exit 0 17:10:44 INFO - Browser initialized. 17:10:44 INFO - Running cycle 1/1 for dromaeo_css test... 17:10:44 INFO - TEST-INFO | started process 27967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSHVqgR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:57 INFO - PROCESS | 27967 | RSS: Main: 185102336 17:10:57 INFO - PROCESS | 27967 | 17:11:46 INFO - PROCESS | 27967 | 1466640706243 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:13:54 INFO - PROCESS | 27967 | Cycle 1(1): loaded http://localhost:49921/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49921/tests/dromaeo/cssquery-ext.html) 17:13:55 INFO - PROCESS | 27967 | RSS: Main: 189825024 17:13:55 INFO - PROCESS | 27967 | 17:16:57 INFO - PROCESS | 27967 | Cycle 1(1): loaded http://localhost:49921/tests/dromaeo/cssquery-ext.html (next: http://localhost:49921/tests/dromaeo/cssquery-jquery.html) 17:16:58 INFO - PROCESS | 27967 | RSS: Main: 188100608 17:16:58 INFO - PROCESS | 27967 | 17:20:00 INFO - PROCESS | 27967 | Cycle 1(1): loaded http://localhost:49921/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49921/tests/dromaeo/cssquery-mootools.html) 17:20:01 INFO - PROCESS | 27967 | RSS: Main: 188973056 17:20:01 INFO - PROCESS | 27967 | 17:23:02 INFO - PROCESS | 27967 | Cycle 1(1): loaded http://localhost:49921/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49921/tests/dromaeo/cssquery-prototype.html) 17:23:03 INFO - PROCESS | 27967 | RSS: Main: 186408960 17:23:03 INFO - PROCESS | 27967 | 17:26:05 INFO - PROCESS | 27967 | Cycle 1(1): loaded http://localhost:49921/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49921/tests/dromaeo/cssquery-yui.html) 17:26:06 INFO - PROCESS | 27967 | RSS: Main: 188485632 17:26:06 INFO - PROCESS | 27967 | 17:29:09 INFO - PROCESS | 27967 | Cycle 1(1): loaded http://localhost:49921/tests/dromaeo/cssquery-yui.html (next: http://localhost:49921/tests/dromaeo/cssquery-dojo.html) 17:29:09 INFO - PROCESS | 27967 | RSS: Main: 190001152 17:29:09 INFO - PROCESS | 27967 | 17:29:09 INFO - PROCESS | 27967 | __start_tp_report 17:29:09 INFO - PROCESS | 27967 | _x_x_mozilla_page_load 17:29:09 INFO - PROCESS | 27967 | _x_x_mozilla_page_load_details 17:29:09 INFO - PROCESS | 27967 | |i|pagename|runs| 17:29:09 INFO - PROCESS | 27967 | |0;dojo.html;3160.5259211118346;3161;3185.1718553176165;3200.9039728808116;3211.2453573410257;5331.333583302087;5417.702026388547;5452.6455780374245;5505.394406615269;5518.034343989796;5354.973225133869;5382.327209098863;5387.4073851876365;5437.619366644337;5493.313335833021;240.5947944689584;4868.780904859272;4914.778834952435;4943.8516844494725;5014.373203349582;4607.838725644603;4770.7376094314795;4862.756862156878;4887.486813884544;4901.509849015088;4898.730569818658;4907.6073914086965;4918.065567542156;4932.014279241839;4940.851774446773;4859.07677541266;4861.314230473702;4890.608751299887;4912.70523768575;4933.851984440473;4855.83004594841;4893.1926232171645;4912.606991440676;4918.581920536759;4963.90072198554;5357.142857142839;5361.973190134064;5375.3280839895015;5408.810691625814;5416.756245968902;5640.915386269168;5681.062624666925;5690.772369105231;5825.213596164548;5868.559858010666;5781.53747700183;5841.153032810219;5847.8538036549;5869.911951320733;5912;5428.2671839301975;5441.619086663935;5457.317835270591;5461.863453413656;5472.534834539069;5704.486596206279;5855.443732845373;5861.589688721834;5951.702414879239;5963.075723262901;5661.490465858093;5664.575156863251;5677.489025987681;5677.886442271214;5752;5740.1102829061565;5740.655560666373;5748.425157484218;5750.051241545182;5760.51035661965;5571.331440227118;5599.720013999366;5616.831495055155;5650.378458369576;5691.743871525791;5637.943620563824;5665.773369065274;5669.659820410706;5678.914816277759;5707.086866101404;4349.195398851222;4369.148016136823;4375.037491751809;4381.693281470267;4414.028913638995;3896.7077469189926;3900.687944964396;3908.394198899175;3928.135810121769;3965.1276719121747;5543.77824887;5545.72271386429;5546.55627549795;5590.552755779528;5618.85952851182;5874.265716785402;5875.823725288248;5880.617759845596;5881.05903055509;5895.29256489224;5487.5884308677005;5492.368377636543;5495.725213739377;5596.2165296858475;5613.943860561424;4912.1158191525865;4954.9752251238515;4995.075910956485;5028.19548872186;5038.798448062036;5906.409359064145;5942.584019118706;5942.910856337158;5966.552508561788;5976.043832986701;5688.687122208318;5716.142578613241;5721.370649228665;5722.6852523109965;5755.107958266475;5847.766089356378;5898.94101058984;5934.961381758261;5982.012967860254;6005.189299444519;5700.429957004267;5710.600257981901;5714.371419143974;5715.542756579547;5737.799177028784;5757.3379061406795;5807.8548036299435;5812.808374283177;5830.2129212555765;5847.94152058474;5379.65032272901;5608.523275521627;5640.294963129609;5672.461116193955;5696;5615.691136987505;5623.746931388179;5628.915566266591;5632.88734225305;5637.2107904894165;5414.593905457185;5554.444555544414;5570.777168913198;5572.526335261548;5585.860353491195;5674.06377947634;5698.059820129798;5702.173184888085;5773.653580785166;5776.393478684846;5593.468620481048;5604.299462567179;5615.747291371979;5627.831165065055;5630.943690563206 17:29:09 INFO - PROCESS | 27967 | |1;ext.html;615.390763144487;634.946029587485;639.9760383386582;653.1443808610717;667.5660820466699;37605.81197094014;38589.421158682606;41665;41796;41895.37156942648;42499.36250956238;42842.57259419247;42871.78564107175;43137;43239;8652.437591556545;8838.955805220965;8854.114588541159;8855.380123391365;8874.156955089256;8732.432391894507;8790.912090879105;8824.117588241157;8864.335174861879;8867.379283450162;8860.645574177026;8880.200781929625;8893.377463577552;8928.866067008968;8945.865812012826;8659.610317535726;8715.128487151298;8824.867626985568;8851.645934162594;8878.24534914533;8716.694915677921;8791.648334066693;8813.471191728517;8830.735077947671;8841.336899732481;34180;39195.60804391948;39660.80169599162;39714.80142599298;39759.40360894589;3043.7260646541918;3390.728741700683;3438.914027149316;3445.8621655133766;3632.037510059836;29955;31616.841915790275;31872.20319492008;32075.198120046953;32748.345033099205;3916.3342231820375;3935.468711723909;4005.5193376794678;4062.410950412174;4135.048938744106;299548;300156;301820;302071;304309;36060.81969590135;36437;36447.63552364495;36508.81745591308;36575.4513682295;35751.82124089363;36805;36892.262154756754;38666.80666596705;38731.2253754929;16971.236294366783;17080;17161.399351022654;17212.311507539558;17234.82765172332;12711.68220794469;12844.935775321064;12885.806712899313;12894.742105158031;12948.287844168473;19712.802871971384;20197.293094741908;20318.695219571717;20345.89827050855;20391.18435262573;7311.23232060626;7439.218882017419;7512.737054203077;7603.543787372775;7622.199669034782;903.8056817784208;985.9852102218473;990.7176454710373;1011.2466212671607;1026.5380578739598;32285.838570806995;32999.34001320008;33012.339753204804;33028.33943321168;33322;1113.2374323588367;1122.3995162587976;1202.971459402216;1236.125750310506;1262.3688155922039;17144.142792860308;17610.823891761174;17788.91105544464;18442.63114737698;18815.62368752617;610850;612221;612383;613455;616110;58835;59668;60111.39888601058;60420.09369859456;60711;1342.3959218351781;1349.2511656030802;1354.2348573056192;1356.2540602668494;1386.895982801294;31626.841865790524;33738.493922591675;33864;33907.15232119217;34378.48432273468;52713;52743.47256527539;53290.46709532855;53369.466305338006;53414.465855340946;486464;489761;491390;495956;496698;28773.424531508834;28910.421791564473;29020.419591608472;29270.121896343142;29736.25659358447;48512.27231591458;49252.2612160825;49574.256386153516;49592.504074960234;50362.49637503578;42330.576694232666;42611.3608295882;42790;43557.78221108874;43599.56400435955;41502.792486037375;42036;42182.578174217866;42403.575964239964;42472.57527424686;38027.2394552113;40895.591044089175;41581.37627935644;41983;42022.78988605038;33803.4929476063;35902.820485897406;36012.27975440529;36562;36833.63166368302;27380.863095684395;27879.442411152068;27904.44191116207;27935.580966285117;28109.297267568476 17:29:09 INFO - PROCESS | 27967 | |2;jquery.html;379.8898319487347;389.1749491078912;393.63588680470593;394.3946042824264;409.7295784782044;13578.864211357883;15172.165530895823;18008.819911800896;19660.705089423653;19712.605747885053;17365.305387784472;17856.732149017742;18718;19221.32725354613;19863.801361986374;5691.51622112121;5810.448007439287;5847.912281315784;5909;5942.881142377149;5622.522085622727;5740.684262365568;5789.16057171712;5830.912536311937;5832.766689332421;5733.598648094614;5752.395998420168;5755.194272801811;5768.913466298009;5771.3074431068335;5734.455226753452;5739.512141467981;5773.538116950634;5780.913286300709;5781.19063331134;5153.948460515385;5162.974185129088;5197.8440646780655;5229.137192363255;5235.031519168966;22384.21655242075;22661.773382266132;23051.423714407105;23489.88255058714;23577.528449431087;2426.781589656922;2437.1104546840274;2494.9875250623813;2502.4995000999693;2505.498900219963;14427.134371937613;14650.120992740363;14742;14803.185824779634;15004.849951500455;1937.2154277517486;1956.814102660245;2000.9995002498752;2008;2011.7384739983854;77274;78839.60580197119;78990.60504697498;79236.20763792346;82001.58999204966;10536.315139515908;10771.353718776898;10862.293950893325;10898.455077246106;11017.338959662286;14728.55814325572;14781;15023.699526009419;15045.322960466805;15064.246787660573;7527.134379546313;7758.262965018314;7791.142974272825;7895.68417263303;7930.5638189898955;7279.963600181965;7357.117145942521;7446.925530744732;7487.812804679927;7523.435742319348;6593.571417857824;6728.293529179464;6730.293319201512;6775.796726098225;6940.479464040217;1904.7238150468104;1944.6110777844488;1946.2701486942397;1953.6092781443767;1957.2464601128383;916.7891384981358;1041.8489319048695;1080.9513571889127;1094.0809719835377;1129.491728722062;19423.611527769364;20018.59962800736;20138.798612013692;20271;20387.388378348674;1014.9898501014895;1020.6835880876952;1045.3780000899453;1045.581767293089;1073.1951036722458;10418.166546676248;11359.716007099723;11420.37187954654;11551.884481155248;11631.185816992898;485325;489573;490254;492524;492612;71621.64189179125;99415.50292248493;101147.49426252821;101734.49132754288;102696.48651756694;1001.6544292219173;1039.0285083447002;1049.0191670787838;1050.5430137890041;1054.1935419404163;17694.380696675555;17844.643107138043;18028.828126171757;18281.908590456962;18471.90764046225;31953.68046319507;38698.03254918649;40863;42527;43661.34507982319;59756;60240.397596025236;61629.691851540454;61862.69068654628;62280.75438491114;8853.73438796837;8907.910920890708;8993.955030224806;9010.729678109667;9224.861627075734;9479.715608531755;10550.788984220426;12429.627111186317;12500.312482813533;12718.554850580185;10872.402017889091;10892.128629709447;11044.392558409365;11192.2700293771;11197.66407007791;10022.047905448972;10805.729856753644;11067.335959842436;11106.555737770399;11141.498632561716;11172.273802202832;11355.318680879174;11377.886221137682;11430.371329576621;11446.37044962535;8762.561871906251;8962.955185224033;9014.459132452073;9050.094990500897;9105.226055785333;10234.488275586042;10329.896701032894;10701.357918524913;10856.34861908288;11444.94277528607 17:29:09 INFO - PROCESS | 27967 | |3;mootools.html;1418.7729963205886;1454.0112723348122;1545.6213227759195;1660.7591899174613;1686.2243368050697;7501.924980750191;8277.255047045765;8367.121452247502;8874.77813054673;8887.555622218888;8522.40343175978;8798.472091674505;8801.075887031866;8809.427387219826;8850.114988501147;2323.9767602323973;2328.871912044837;2368.0291080656934;2368.9339797091293;2369.0168580039262;2276.6926464927187;2286.8856557172157;2317.5017371265176;2323.2797832671927;2343.7070366204225;2308.1575225042907;2323.465602911331;2337.2053501809382;2337.777911098443;2348.236823032513;2243.7868402501817;2298.1152256381247;2315.6642286868478;2324.7675232476786;2331.393837602227;2255.4699645583273;2279.974011694744;2283.8515496492673;2286.371247906822;2304.43541332373;8757.343199260082;8826.470411775314;8896.332775041898;8896.510691911943;8929.062448442884;5069.847904562869;5135.743212839343;5168.767405466763;5177.974110129463;5227.372715274191;3063.3107550801114;3194.472911969522;3250.0574833298315;3268.7221586165206;3275.8525866335835;1090.983635245472;1100.7028102412303;1124.3478782306324;1129.13056946151;1134.6425875849081;12063.155579109465;12087.395630218542;12241.93879030608;12311.19977201488;12331;4379.343098535245;4443.178012067713;4509.255972764523;4530.139273538083;4535.138323718483;10274.589016439408;10338.172946164288;10367.429791361548;10388.636397726043;10498.055175034284;5116.130257856174;5123.129068058439;5127.743612819344;5130.050940576006;5131.974340128276;4156.605122513356;4575.3823233863;4650.67445278834;4707.129181101507;4720.45714742809;3750.7374483785875;3852.7110466715108;3890.0469385000856;3958.762474251554;4080.81636326366;1250.7748605251143;1255.7614053329837;1256.5225214418645;1268.7018550640591;1279.1941077121353;819.4591569564178;882.7660669922476;924.3437159616612;930.8371035068972;946.8816397950256;5782.306123265235;5794.072948328248;5816.360200377955;5898.14476900847;6106.2061931948565;455.79944824277874;466.2609763524851;475.9833405830779;480.58909632264607;481.480001598273;3844.2695887781792;4069.9796501017304;4114.0948991221885;4138.985948442651;4145.336746120606;10477.84283235752;10651.520681569347;10686;10788.298760580537;10803.729906752395;10187.337823041478;10562.31344962575;10568.313059651098;10587.735306617242;10676.839847402296;7977.122516523178;8160.795980100545;8176.305014073751;8218.424710270223;8236.588170591447;5746.597738158289;6066.332703402711;6077.574569780073;6083;6191.4118158774845;9589.136977672042;10067.69796906094;10076.94961525217;10236.436995965294;10255.641052563124;10119.241056920613;10130.898691012995;10137.543810528692;10249;10255.94872025635;7043;7547.5848828314965;7820.608969551614;7839.568823714522;7919.881201781863;8656.523891185794;8661.653533858575;8683.522406267715;8722.651093956425;8746.037935826927;7738.458307918617;7791.727289544839;7896.131425543301;8023.919760802317;8039.437239393186;7642.312191902755;7663.8850417242675;7717.57553334572;7798;7813.570253636105;6843.144606924135;6913.41235994926;6929.89605155913;6937.7571784987285;6949.617771022642;4716.64625153108;4967.031428871335;5093.2105523643895;5114.897702045864;5206.791728330824;5188.22176673502;5237.973810130925;5279.419263880894;5303.893922121459;5327.493888080626 17:29:09 INFO - PROCESS | 27967 | |4;prototype.html;313.50153256322426;325.8028892520026;327.9195052302664;329.9340131973605;333.8747969511433;5577.888442231153;5653.643125649845;5657.151427285909;5689.914651280229;5771.711414429272;5619.353774315955;5637.718114094289;5661.264035675366;5670.0927851543765;5680.772769089232;4346.739195648272;4349.999000459792;4382.496012958519;4385.451818522684;4392.758398288093;4276.909388106029;4391;4394.07724377881;4414.646828253732;4414.757188354639;4319.719218250803;4347.652187824967;4362.5637436256275;4377.190219809346;4379.693421460499;4376.6936314458;4378.321360189176;4407.911841763147;4408.7575183365225;4419.099787091549;3617.385044542434;3810.866619668326;3850.1337199130253;3860.1314704191614;3864.3623802072625;5424.484673955968;5475.342958844924;5501.449855014466;5517.806876759334;5542.4457554244655;4896.779644915951;4922.237053256715;4947.777350019258;4975.4527002029745;5015.32293140425;5498.642588231752;5778.27771528559;5881.323647780518;5895.941040589582;5899.970500147515;4012.177503611782;4023.3562629979356;4030.7984600769846;4059.939100913489;4075.7962101894786;5994.220751302347;6146.29317628474;6163.383661633846;6179.752809887599;6191;4234.767087810138;4245.363195520635;4255.6169944705125;4259.488861336659;4264.891128306663;4293.205756934977;4295.398644189816;4347.1740369330355;4356.324769660708;4372.278574035312;4843.297721830315;4936.259561065869;4949.529794669501;4954.405471343462;4972.632526055291;5923.585349025527;5967.224260846062;5968.940310596839;5995.61028533144;6046.18376519173;1442.7619442791822;1462.1738717624507;1463.8097047383771;1463.9560813175622;1467.325030485967;921.9815603688023;943.3396622364372;950.847864341702;957.2581249531669;971.7998272133909;5113.258577506241;5121.308623335876;5152.355955505562;5198.454162312903;5217.9478205217465;5365.195220716923;5400.864978375494;5467.234587157801;5482.588805839578;5520.254765606672;4930.207006767035;5205.895882082337;5212.166053431509;5217.556507696889;5243.475652434726;2871.956920646192;2890.7976441648884;2908.927276818054;2949.675535691072;2950.3066779306846;5537.363203231599;5601.467860553241;5629.296337957755;5648.85877853057;5664.376918538957;5141.584536558061;5369.7583608737705;5383.488568585978;5436.565074794007;5479.904019196177;5500.4499550045475;5561.860953476195;5612.242347283146;5631.831045068655;5642.181883626851;5230.712310822942;5232.770298979813;5385.92281543685;5395.919061214164;5397.299850547222;5308.681479111266;5311.973440132774;5358.705271210121;5380.623356365017;5395.163749618815;5997.5501837363245;6114.174586430775;6275.435210831047;6355.72885422908;6375.904361434675;4366.912661746684;4408.861702074427;4421.646268298464;4423.469183697848;4424.225760491965;5808.332041815245;6039.4262545058145;6080.7567697291615;6122.44897959168;6143.938560614337;5889.882202356014;5922.881542369215;5934.821955341346;5951.7619295227705;5964.7912323068485;5873.295204575478;5876.559258055749;5949.672767997628;5954.3152537458745;5979.402059793986;5651.547876169979;5811.389804070681;5825.533957283492;5841.561882858718;5855.648661080349;5891;5928.8814223716145;5954.3152537458745;6000.549958753199;6038.426349496791;5741.540676745767;5746.42535746422;5768.826935191951;5846.473817356288;5868.327526654883 17:29:09 INFO - PROCESS | 27967 | |5;yui.html;730.4010711216803;757.7310054930499;771.3173841150583;778.5834578500502;779.9337056350209;14842.183679897602;15675.843241567582;15757.763633545492;15778.842211577881;15815.367385304575;14850.702985940276;14962.32669529871;14991.325390357433;15000.324985375657;15013.699726005474;654.9410553050225;782.4131901074194;790.4861839804116;808.8422757562278;813.2152472863685;791.9406044546653;796.9760907172794;798.6406117247233;798.8042929482285;799.5802203843;848.6605357856845;852.0797538658235;853.1212850763692;854.6325080215505;854.9102344253826;848.9702860399888;850.056437354536;850.2772643253247;850.4174640371334;852.211704173643;610.5420934299276;612.9172561704157;617.0743884173739;617.0928734759896;619.7830759234276;14708.852911470962;14752.40990360395;14760.48338308154;14771.113733176044;14914.776278355834;14012.71974560503;14191.290435478288;14239.430422783076;14257.215853128073;14369.281535923163;12124.151309408346;12148.45331960055;12269.93865030678;12304.446299916435;12343.259404435763;3874.438206460076;4073.9388909166387;4079.1433798902267;4125.8968525786795;4132.359484279941;80958.20895522447;81089.18910810875;81485.59257203677;81547.5922620389;82215;10279.17766578672;10372.170226381872;10428.687139385831;10506.951956967143;10636.042756151828;22031.779682203294;22055.779442205694;22066.66899996501;22068.2276120335;22072.558548828933;8110.148434414419;8114;8321.334293256525;8343.123971982975;8359.540225287546;4537.727736335831;4665.9766701166955;4712.31671407644;4728.550787675165;4790.808367665324;3227.193201699575;3296.604407471119;3320.66793320666;3337.983310083434;3382.9323413531592;600.2107228993947;604.3231580629723;609.5306613907267;620.2371083567148;621.8818424499331;607.614165005216;627.9529035322369;679.7281087564915;708.0794966543473;740.0822979505375;8515.48907065578;8767.430117042371;9042.954785226031;9276.675316363895;9443.669471568599;578.2396149063967;626.9936751513845;649.3344322069822;663.1942190238883;675.4022689919457;4101.630853223224;4292.068309679845;4357.586029327209;4392.2094023075515;4470.374147619336;71099.28900710927;71946.28053719501;95529.5223523878;96677.51661241648;99320.50339748255;96587;97576.51211743896;98116;99228;99776;56766.432335676116;65540.67229663917;88751.55624221837;89895;91327.5433622841;9009.909900900908;9467.072460014126;9548.331616787036;9560.303761137067;9736.318457708176;44370.556294437934;47602.28596570985;49508.50491495183;50001;50054.499455006444;48852.5114748848;50854.23718644297;67165;68647.65676171587;73959;12234.224667920646;12346.3826808661;12515.311657858905;12524.185927914656;12560.806723361266;13573.253471058792;13587.59237222885;14135;14162.656568019003;15088.094714317176;12908;13028.348582570645;13266.933665331611;13566.186028838301;13674.521391751241;13062.673433163867;13169.47322107105;13988;14057.644596254291;14253.572392828231;12441.066919980856;12840.101192916407;13541.1198272112;13681.452741890213;14437.989340746048;10647.787044259227;10835.295705779099;10955.178361622751;11067.280626759235;11658.6502404928;10598.31110977784;10737.516811743333;10766.623168189075;11059.72350691239;11064.114870810155 17:29:09 INFO - PROCESS | 27967 | __end_tp_report 17:29:09 INFO - PROCESS | 27967 | __start_cc_report 17:29:09 INFO - PROCESS | 27967 | _x_x_mozilla_cycle_collect,360 17:29:09 INFO - PROCESS | 27967 | __end_cc_report 17:29:09 INFO - PROCESS | 27967 | __startTimestamp1466641749299__endTimestamp 17:29:09 INFO - PROCESS | 27967 | 17:29:09 INFO - PROCESS | 27967 | ------- Summary: start ------- 17:29:09 INFO - PROCESS | 27967 | Number of tests: 6 17:29:09 INFO - PROCESS | 27967 | 17:29:09 INFO - PROCESS | 27967 | [#0] dojo.html Cycles:165 Average:5336.24 Median:5604.30 stddev:724.39 (12.9%) stddev-sans-first:706.22 17:29:09 INFO - PROCESS | 27967 | Values: 3160.5 3161.0 3185.2 3200.9 3211.2 5331.3 5417.7 5452.6 5505.4 5518.0 5355.0 5382.3 5387.4 5437.6 5493.3 240.6 4868.8 4914.8 4943.9 5014.4 4607.8 4770.7 4862.8 4887.5 4901.5 4898.7 4907.6 4918.1 4932.0 4940.9 4859.1 4861.3 4890.6 4912.7 4933.9 4855.8 4893.2 4912.6 4918.6 4963.9 5357.1 5362.0 5375.3 5408.8 5416.8 5640.9 5681.1 5690.8 5825.2 5868.6 5781.5 5841.2 5847.9 5869.9 5912.0 5428.3 5441.6 5457.3 5461.9 5472.5 5704.5 5855.4 5861.6 5951.7 5963.1 5661.5 5664.6 5677.5 5677.9 5752.0 5740.1 5740.7 5748.4 5750.1 5760.5 5571.3 5599.7 5616.8 5650.4 5691.7 5637.9 5665.8 5669.7 5678.9 5707.1 4349.2 4369.1 4375.0 4381.7 4414.0 3896.7 3900.7 3908.4 3928.1 3965.1 5543.8 5545.7 5546.6 5590.6 5618.9 5874.3 5875.8 5880.6 5881.1 5895.3 5487.6 5492.4 5495.7 5596.2 5613.9 4912.1 4955.0 4995.1 5028.2 5038.8 5906.4 5942.6 5942.9 5966.6 5976.0 5688.7 5716.1 5721.4 5722.7 5755.1 5847.8 5898.9 5935.0 5982.0 6005.2 5700.4 5710.6 5714.4 5715.5 5737.8 5757.3 5807.9 5812.8 5830.2 5847.9 5379.7 5608.5 5640.3 5672.5 5696.0 5615.7 5623.7 5628.9 5632.9 5637.2 5414.6 5554.4 5570.8 5572.5 5585.9 5674.1 5698.1 5702.2 5773.7 5776.4 5593.5 5604.3 5615.7 5627.8 5630.9 17:29:09 INFO - PROCESS | 27967 | 17:29:09 INFO - PROCESS | 27967 | [#1] ext.html Cycles:180 Average:61468.90 Median:39737.10 stddev:129725.16 (326.5%) stddev-sans-first:130008.62 17:29:09 INFO - PROCESS | 27967 | Values: 615.4 634.9 640.0 653.1 667.6 37605.8 38589.4 41665.0 41796.0 41895.4 42499.4 42842.6 42871.8 43137.0 43239.0 8652.4 8839.0 8854.1 8855.4 8874.2 8732.4 8790.9 8824.1 8864.3 8867.4 8860.6 8880.2 8893.4 8928.9 8945.9 8659.6 8715.1 8824.9 8851.6 8878.2 8716.7 8791.6 8813.5 8830.7 8841.3 34180.0 39195.6 39660.8 39714.8 39759.4 3043.7 3390.7 3438.9 3445.9 3632.0 29955.0 31616.8 31872.2 32075.2 32748.3 3916.3 3935.5 4005.5 4062.4 4135.0 299548.0 300156.0 301820.0 302071.0 304309.0 36060.8 36437.0 36447.6 36508.8 36575.5 35751.8 36805.0 36892.3 38666.8 38731.2 16971.2 17080.0 17161.4 17212.3 17234.8 12711.7 12844.9 12885.8 12894.7 12948.3 19712.8 20197.3 20318.7 20345.9 20391.2 7311.2 7439.2 7512.7 7603.5 7622.2 903.8 986.0 990.7 1011.2 1026.5 32285.8 32999.3 33012.3 33028.3 33322.0 1113.2 1122.4 1203.0 1236.1 1262.4 17144.1 17610.8 17788.9 18442.6 18815.6 610850.0 612221.0 612383.0 613455.0 616110.0 58835.0 59668.0 60111.4 60420.1 60711.0 1342.4 1349.3 1354.2 1356.3 1386.9 31626.8 33738.5 33864.0 33907.2 34378.5 52713.0 52743.5 53290.5 53369.5 53414.5 486464.0 489761.0 491390.0 495956.0 496698.0 28773.4 28910.4 29020.4 29270.1 29736.3 48512.3 49252.3 49574.3 49592.5 50362.5 42330.6 42611.4 42790.0 43557.8 43599.6 41502.8 42036.0 42182.6 42403.6 42472.6 38027.2 40895.6 41581.4 41983.0 42022.8 33803.5 35902.8 36012.3 36562.0 36833.6 27380.9 27879.4 27904.4 27935.6 28109.3 17:29:09 INFO - PROCESS | 27967 | 17:29:09 INFO - PROCESS | 27967 | [#2] jquery.html Cycles:180 Average:29103.13 Median:21385.80 stddev:80885.28 (378.2%) stddev-sans-first:81083.43 17:29:09 INFO - PROCESS | 27967 | Values: 379.9 389.2 393.6 394.4 409.7 13578.9 15172.2 18008.8 19660.7 19712.6 17365.3 17856.7 18718.0 19221.3 19863.8 5691.5 5810.4 5847.9 5909.0 5942.9 5622.5 5740.7 5789.2 5830.9 5832.8 5733.6 5752.4 5755.2 5768.9 5771.3 5734.5 5739.5 5773.5 5780.9 5781.2 5153.9 5163.0 5197.8 5229.1 5235.0 22384.2 22661.8 23051.4 23489.9 23577.5 2426.8 2437.1 2495.0 2502.5 2505.5 14427.1 14650.1 14742.0 14803.2 15004.8 1937.2 1956.8 2001.0 2008.0 2011.7 77274.0 78839.6 78990.6 79236.2 82001.6 10536.3 10771.4 10862.3 10898.5 11017.3 14728.6 14781.0 15023.7 15045.3 15064.2 7527.1 7758.3 7791.1 7895.7 7930.6 7280.0 7357.1 7446.9 7487.8 7523.4 6593.6 6728.3 6730.3 6775.8 6940.5 1904.7 1944.6 1946.3 1953.6 1957.2 916.8 1041.8 1081.0 1094.1 1129.5 19423.6 20018.6 20138.8 20271.0 20387.4 1015.0 1020.7 1045.4 1045.6 1073.2 10418.2 11359.7 11420.4 11551.9 11631.2 485325.0 489573.0 490254.0 492524.0 492612.0 71621.6 99415.5 101147.5 101734.5 102696.5 1001.7 1039.0 1049.0 1050.5 1054.2 17694.4 17844.6 18028.8 18281.9 18471.9 31953.7 38698.0 40863.0 42527.0 43661.3 59756.0 60240.4 61629.7 61862.7 62280.8 8853.7 8907.9 8994.0 9010.7 9224.9 9479.7 10550.8 12429.6 12500.3 12718.6 10872.4 10892.1 11044.4 11192.3 11197.7 10022.0 10805.7 11067.3 11106.6 11141.5 11172.3 11355.3 11377.9 11430.4 11446.4 8762.6 8963.0 9014.5 9050.1 9105.2 10234.5 10329.9 10701.4 10856.3 11444.9 17:29:09 INFO - PROCESS | 27967 | 17:29:09 INFO - PROCESS | 27967 | [#3] mootools.html Cycles:180 Average:5739.07 Median:2515.59 stddev:3297.57 (131.1%) stddev-sans-first:3290.84 17:29:09 INFO - PROCESS | 27967 | Values: 1418.8 1454.0 1545.6 1660.8 1686.2 7501.9 8277.3 8367.1 8874.8 8887.6 8522.4 8798.5 8801.1 8809.4 8850.1 2324.0 2328.9 2368.0 2368.9 2369.0 2276.7 2286.9 2317.5 2323.3 2343.7 2308.2 2323.5 2337.2 2337.8 2348.2 2243.8 2298.1 2315.7 2324.8 2331.4 2255.5 2280.0 2283.9 2286.4 2304.4 8757.3 8826.5 8896.3 8896.5 8929.1 5069.8 5135.7 5168.8 5178.0 5227.4 3063.3 3194.5 3250.1 3268.7 3275.9 1091.0 1100.7 1124.3 1129.1 1134.6 12063.2 12087.4 12241.9 12311.2 12331.0 4379.3 4443.2 4509.3 4530.1 4535.1 10274.6 10338.2 10367.4 10388.6 10498.1 5116.1 5123.1 5127.7 5130.1 5132.0 4156.6 4575.4 4650.7 4707.1 4720.5 3750.7 3852.7 3890.0 3958.8 4080.8 1250.8 1255.8 1256.5 1268.7 1279.2 819.5 882.8 924.3 930.8 946.9 5782.3 5794.1 5816.4 5898.1 6106.2 455.8 466.3 476.0 480.6 481.5 3844.3 4070.0 4114.1 4139.0 4145.3 10477.8 10651.5 10686.0 10788.3 10803.7 10187.3 10562.3 10568.3 10587.7 10676.8 7977.1 8160.8 8176.3 8218.4 8236.6 5746.6 6066.3 6077.6 6083.0 6191.4 9589.1 10067.7 10076.9 10236.4 10255.6 10119.2 10130.9 10137.5 10249.0 10255.9 7043.0 7547.6 7820.6 7839.6 7919.9 8656.5 8661.7 8683.5 8722.7 8746.0 7738.5 7791.7 7896.1 8023.9 8039.4 7642.3 7663.9 7717.6 7798.0 7813.6 6843.1 6913.4 6929.9 6937.8 6949.6 4716.6 4967.0 5093.2 5114.9 5206.8 5188.2 5238.0 5279.4 5303.9 5327.5 17:29:09 INFO - PROCESS | 27967 | 17:29:09 INFO - PROCESS | 27967 | [#4] prototype.html Cycles:180 Average:4813.57 Median:5390.54 stddev:1409.73 (26.2%) stddev-sans-first:1372.62 17:29:09 INFO - PROCESS | 27967 | Values: 313.5 325.8 327.9 329.9 333.9 5577.9 5653.6 5657.2 5689.9 5771.7 5619.4 5637.7 5661.3 5670.1 5680.8 4346.7 4350.0 4382.5 4385.5 4392.8 4276.9 4391.0 4394.1 4414.6 4414.8 4319.7 4347.7 4362.6 4377.2 4379.7 4376.7 4378.3 4407.9 4408.8 4419.1 3617.4 3810.9 3850.1 3860.1 3864.4 5424.5 5475.3 5501.4 5517.8 5542.4 4896.8 4922.2 4947.8 4975.5 5015.3 5498.6 5778.3 5881.3 5895.9 5900.0 4012.2 4023.4 4030.8 4059.9 4075.8 5994.2 6146.3 6163.4 6179.8 6191.0 4234.8 4245.4 4255.6 4259.5 4264.9 4293.2 4295.4 4347.2 4356.3 4372.3 4843.3 4936.3 4949.5 4954.4 4972.6 5923.6 5967.2 5968.9 5995.6 6046.2 1442.8 1462.2 1463.8 1464.0 1467.3 922.0 943.3 950.8 957.3 971.8 5113.3 5121.3 5152.4 5198.5 5217.9 5365.2 5400.9 5467.2 5482.6 5520.3 4930.2 5205.9 5212.2 5217.6 5243.5 2872.0 2890.8 2908.9 2949.7 2950.3 5537.4 5601.5 5629.3 5648.9 5664.4 5141.6 5369.8 5383.5 5436.6 5479.9 5500.4 5561.9 5612.2 5631.8 5642.2 5230.7 5232.8 5385.9 5395.9 5397.3 5308.7 5312.0 5358.7 5380.6 5395.2 5997.6 6114.2 6275.4 6355.7 6375.9 4366.9 4408.9 4421.6 4423.5 4424.2 5808.3 6039.4 6080.8 6122.4 6143.9 5889.9 5922.9 5934.8 5951.8 5964.8 5873.3 5876.6 5949.7 5954.3 5979.4 5651.5 5811.4 5825.5 5841.6 5855.6 5891.0 5928.9 5954.3 6000.5 6038.4 5741.5 5746.4 5768.8 5846.5 5868.3 17:29:09 INFO - PROCESS | 27967 | 17:29:09 INFO - PROCESS | 27967 | [#5] yui.html Cycles:180 Average:19390.19 Median:26196.55 stddev:27046.12 (103.2%) stddev-sans-first:27085.70 17:29:09 INFO - PROCESS | 27967 | Values: 730.4 757.7 771.3 778.6 779.9 14842.2 15675.8 15757.8 15778.8 15815.4 14850.7 14962.3 14991.3 15000.3 15013.7 654.9 782.4 790.5 808.8 813.2 791.9 797.0 798.6 798.8 799.6 848.7 852.1 853.1 854.6 854.9 849.0 850.1 850.3 850.4 852.2 610.5 612.9 617.1 617.1 619.8 14708.9 14752.4 14760.5 14771.1 14914.8 14012.7 14191.3 14239.4 14257.2 14369.3 12124.2 12148.5 12269.9 12304.4 12343.3 3874.4 4073.9 4079.1 4125.9 4132.4 80958.2 81089.2 81485.6 81547.6 82215.0 10279.2 10372.2 10428.7 10507.0 10636.0 22031.8 22055.8 22066.7 22068.2 22072.6 8110.1 8114.0 8321.3 8343.1 8359.5 4537.7 4666.0 4712.3 4728.6 4790.8 3227.2 3296.6 3320.7 3338.0 3382.9 600.2 604.3 609.5 620.2 621.9 607.6 628.0 679.7 708.1 740.1 8515.5 8767.4 9043.0 9276.7 9443.7 578.2 627.0 649.3 663.2 675.4 4101.6 4292.1 4357.6 4392.2 4470.4 71099.3 71946.3 95529.5 96677.5 99320.5 96587.0 97576.5 98116.0 99228.0 99776.0 56766.4 65540.7 88751.6 89895.0 91327.5 9009.9 9467.1 9548.3 9560.3 9736.3 44370.6 47602.3 49508.5 50001.0 50054.5 48852.5 50854.2 67165.0 68647.7 73959.0 12234.2 12346.4 12515.3 12524.2 12560.8 13573.3 13587.6 14135.0 14162.7 15088.1 12908.0 13028.3 13266.9 13566.2 13674.5 13062.7 13169.5 13988.0 14057.6 14253.6 12441.1 12840.1 13541.1 13681.5 14438.0 10647.8 10835.3 10955.2 11067.3 11658.7 10598.3 10737.5 10766.6 11059.7 11064.1 17:29:09 INFO - PROCESS | 27967 | -------- Summary: end -------- 17:29:09 INFO - PROCESS | 27967 | 17:29:10 INFO - TEST-INFO | 27967: exit 0 17:29:10 INFO - TEST-OK | dromaeo_css | took 1115989ms 17:29:10 INFO - TEST-START | kraken 17:29:10 INFO - operating with platform_type : linux_ 17:29:10 INFO - Initialising browser for kraken test... 17:29:10 INFO - TEST-INFO | started process 28205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7vyLCH/profile http://localhost:49921/getInfo.html) 17:29:17 INFO - PROCESS | 28205 | __metrics Screen width/height:1600/1200 17:29:17 INFO - PROCESS | 28205 | colorDepth:24 17:29:17 INFO - PROCESS | 28205 | Browser inner width/height: 1024/697 17:29:17 INFO - PROCESS | 28205 | __metrics 17:29:18 ERROR - PROCESS | 28205 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 17:29:19 INFO - TEST-INFO | 28205: exit 0 17:29:19 INFO - Browser initialized. 17:29:19 INFO - Running cycle 1/1 for kraken test... 17:29:19 INFO - TEST-INFO | started process 28325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7vyLCH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:31 INFO - PROCESS | 28325 | RSS: Main: 184868864 17:29:31 INFO - PROCESS | 28325 | 17:29:34 INFO - PROCESS | 28325 | Cycle 1(1): loaded http://localhost:49921/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49921/tests/kraken/driver.html?testName=audio-beat-detection) 17:29:34 INFO - PROCESS | 28325 | RSS: Main: 191332352 17:29:34 INFO - PROCESS | 28325 | 17:29:37 INFO - PROCESS | 28325 | Cycle 1(1): loaded http://localhost:49921/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49921/tests/kraken/driver.html?testName=audio-dft) 17:29:38 INFO - PROCESS | 28325 | RSS: Main: 190386176 17:29:38 INFO - PROCESS | 28325 | 17:29:41 INFO - PROCESS | 28325 | Cycle 1(1): loaded http://localhost:49921/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49921/tests/kraken/driver.html?testName=audio-fft) 17:29:41 INFO - PROCESS | 28325 | RSS: Main: 186200064 17:29:41 INFO - PROCESS | 28325 | 17:29:43 INFO - PROCESS | 28325 | Cycle 1(1): loaded http://localhost:49921/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49921/tests/kraken/driver.html?testName=audio-oscillator) 17:29:44 INFO - PROCESS | 28325 | RSS: Main: 186425344 17:29:44 INFO - PROCESS | 28325 | 17:29:46 INFO - PROCESS | 28325 | Cycle 1(1): loaded http://localhost:49921/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49921/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:29:47 INFO - PROCESS | 28325 | RSS: Main: 186515456 17:29:47 INFO - PROCESS | 28325 | 17:29:50 INFO - PROCESS | 28325 | Cycle 1(1): loaded http://localhost:49921/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49921/tests/kraken/driver.html?testName=imaging-darkroom) 17:29:51 INFO - PROCESS | 28325 | RSS: Main: 186105856 17:29:51 INFO - PROCESS | 28325 | 17:29:54 INFO - PROCESS | 28325 | Cycle 1(1): loaded http://localhost:49921/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49921/tests/kraken/driver.html?testName=imaging-desaturate) 17:29:55 INFO - PROCESS | 28325 | RSS: Main: 183902208 17:29:55 INFO - PROCESS | 28325 | 17:29:57 INFO - PROCESS | 28325 | Cycle 1(1): loaded http://localhost:49921/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49921/tests/kraken/driver.html?testName=json-parse-financial) 17:29:58 INFO - PROCESS | 28325 | RSS: Main: 185425920 17:29:58 INFO - PROCESS | 28325 | 17:30:00 INFO - PROCESS | 28325 | Cycle 1(1): loaded http://localhost:49921/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49921/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:30:00 INFO - PROCESS | 28325 | RSS: Main: 185806848 17:30:00 INFO - PROCESS | 28325 | 17:30:02 INFO - PROCESS | 28325 | Cycle 1(1): loaded http://localhost:49921/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49921/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:30:03 INFO - PROCESS | 28325 | RSS: Main: 186134528 17:30:03 INFO - PROCESS | 28325 | 17:30:05 INFO - PROCESS | 28325 | Cycle 1(1): loaded http://localhost:49921/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49921/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:30:06 INFO - PROCESS | 28325 | RSS: Main: 185978880 17:30:06 INFO - PROCESS | 28325 | 17:30:08 INFO - PROCESS | 28325 | Cycle 1(1): loaded http://localhost:49921/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49921/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:30:09 INFO - PROCESS | 28325 | RSS: Main: 186183680 17:30:09 INFO - PROCESS | 28325 | 17:30:12 INFO - PROCESS | 28325 | Cycle 1(1): loaded http://localhost:49921/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49921/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:30:12 INFO - PROCESS | 28325 | RSS: Main: 186073088 17:30:12 INFO - PROCESS | 28325 | 17:30:14 INFO - PROCESS | 28325 | Cycle 1(1): loaded http://localhost:49921/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49921/tests/kraken/driver.html?testName=ai-astar) 17:30:14 INFO - PROCESS | 28325 | RSS: Main: 187392000 17:30:14 INFO - PROCESS | 28325 | 17:30:14 INFO - PROCESS | 28325 | __start_tp_report 17:30:14 INFO - PROCESS | 28325 | _x_x_mozilla_page_load 17:30:14 INFO - PROCESS | 28325 | _x_x_mozilla_page_load_details 17:30:14 INFO - PROCESS | 28325 | |i|pagename|runs| 17:30:14 INFO - PROCESS | 28325 | |0;ai-astar;104;112;105;109;112;113;114;111;112;113 17:30:14 INFO - PROCESS | 28325 | |1;audio-beat-detection;158;129;154;179;128;155;151;127;185;126 17:30:14 INFO - PROCESS | 28325 | |2;audio-dft;163;161;164;162;165;170;162;166;162;164 17:30:14 INFO - PROCESS | 28325 | |3;audio-fft;75;76;76;155;77;76;75;76;158;76 17:30:14 INFO - PROCESS | 28325 | |4;audio-oscillator;85;85;144;85;85;86;153;86;86;151 17:30:14 INFO - PROCESS | 28325 | |5;imaging-gaussian-blur;118;119;117;118;117;117;117;118;118;117 17:30:14 INFO - PROCESS | 28325 | |6;imaging-darkroom;148;148;149;148;150;148;149;148;148;148 17:30:14 INFO - PROCESS | 28325 | |7;imaging-desaturate;95;98;96;96;96;96;96;96;95;95 17:30:14 INFO - PROCESS | 28325 | |8;json-parse-financial;55;56;57;55;59;55;55;55;56;54 17:30:14 INFO - PROCESS | 28325 | |9;json-stringify-tinderbox;62;64;61;62;62;61;61;63;62;63 17:30:14 INFO - PROCESS | 28325 | |10;stanford-crypto-aes;87;78;78;85;83;88;79;81;88;80 17:30:14 INFO - PROCESS | 28325 | |11;stanford-crypto-ccm;136;123;134;128;129;139;126;145;128;135 17:30:14 INFO - PROCESS | 28325 | |12;stanford-crypto-pbkdf2;165;170;162;157;161;158;165;164;162;162 17:30:14 INFO - PROCESS | 28325 | |13;stanford-crypto-sha256-iterative;64;65;64;62;74;62;65;66;63;63 17:30:14 INFO - PROCESS | 28325 | __end_tp_report 17:30:14 INFO - PROCESS | 28325 | __start_cc_report 17:30:14 INFO - PROCESS | 28325 | _x_x_mozilla_cycle_collect,901 17:30:14 INFO - PROCESS | 28325 | __end_cc_report 17:30:14 INFO - PROCESS | 28325 | __startTimestamp1466641814561__endTimestamp 17:30:14 INFO - PROCESS | 28325 | 17:30:14 INFO - PROCESS | 28325 | ------- Summary: start ------- 17:30:14 INFO - PROCESS | 28325 | Number of tests: 14 17:30:14 INFO - PROCESS | 28325 | 17:30:14 INFO - PROCESS | 28325 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.44 (3.1%) stddev-sans-first:2.73 17:30:14 INFO - PROCESS | 28325 | Values: 104.0 112.0 105.0 109.0 112.0 113.0 114.0 111.0 112.0 113.0 17:30:14 INFO - PROCESS | 28325 | 17:30:14 INFO - PROCESS | 28325 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:154.50 stddev:21.59 (14.0%) stddev-sans-first:22.66 17:30:14 INFO - PROCESS | 28325 | Values: 158.0 129.0 154.0 179.0 128.0 155.0 151.0 127.0 185.0 126.0 17:30:14 INFO - PROCESS | 28325 | 17:30:14 INFO - PROCESS | 28325 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.64 (1.6%) stddev-sans-first:2.78 17:30:14 INFO - PROCESS | 28325 | Values: 163.0 161.0 164.0 162.0 165.0 170.0 162.0 166.0 162.0 164.0 17:30:14 INFO - PROCESS | 28325 | 17:30:14 INFO - PROCESS | 28325 | [#3] audio-fft Cycles:10 Average:92.00 Median:76.00 stddev:34.01 (44.7%) stddev-sans-first:35.51 17:30:14 INFO - PROCESS | 28325 | Values: 75.0 76.0 76.0 155.0 77.0 76.0 75.0 76.0 158.0 76.0 17:30:14 INFO - PROCESS | 28325 | 17:30:14 INFO - PROCESS | 28325 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:85.00 stddev:30.95 (36.4%) stddev-sans-first:32.01 17:30:14 INFO - PROCESS | 28325 | Values: 85.0 85.0 144.0 85.0 85.0 86.0 153.0 86.0 86.0 151.0 17:30:14 INFO - PROCESS | 28325 | 17:30:14 INFO - PROCESS | 28325 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 17:30:14 INFO - PROCESS | 28325 | Values: 118.0 119.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 17:30:14 INFO - PROCESS | 28325 | 17:30:14 INFO - PROCESS | 28325 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 17:30:14 INFO - PROCESS | 28325 | Values: 148.0 148.0 149.0 148.0 150.0 148.0 149.0 148.0 148.0 148.0 17:30:14 INFO - PROCESS | 28325 | 17:30:14 INFO - PROCESS | 28325 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 17:30:14 INFO - PROCESS | 28325 | Values: 95.0 98.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 17:30:14 INFO - PROCESS | 28325 | 17:30:14 INFO - PROCESS | 28325 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.50 stddev:1.42 (2.6%) stddev-sans-first:1.48 17:30:14 INFO - PROCESS | 28325 | Values: 55.0 56.0 57.0 55.0 59.0 55.0 55.0 55.0 56.0 54.0 17:30:14 INFO - PROCESS | 28325 | 17:30:14 INFO - PROCESS | 28325 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 17:30:14 INFO - PROCESS | 28325 | Values: 62.0 64.0 61.0 62.0 62.0 61.0 61.0 63.0 62.0 63.0 17:30:14 INFO - PROCESS | 28325 | 17:30:14 INFO - PROCESS | 28325 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:84.00 stddev:4.06 (4.8%) stddev-sans-first:3.99 17:30:14 INFO - PROCESS | 28325 | Values: 87.0 78.0 78.0 85.0 83.0 88.0 79.0 81.0 88.0 80.0 17:30:14 INFO - PROCESS | 28325 | 17:30:14 INFO - PROCESS | 28325 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:134.50 stddev:6.70 (5.0%) stddev-sans-first:6.97 17:30:14 INFO - PROCESS | 28325 | Values: 136.0 123.0 134.0 128.0 129.0 139.0 126.0 145.0 128.0 135.0 17:30:14 INFO - PROCESS | 28325 | 17:30:14 INFO - PROCESS | 28325 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.60 Median:163.00 stddev:3.72 (2.3%) stddev-sans-first:3.84 17:30:14 INFO - PROCESS | 28325 | Values: 165.0 170.0 162.0 157.0 161.0 158.0 165.0 164.0 162.0 162.0 17:30:14 INFO - PROCESS | 28325 | 17:30:14 INFO - PROCESS | 28325 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:64.50 stddev:3.49 (5.4%) stddev-sans-first:3.69 17:30:14 INFO - PROCESS | 28325 | Values: 64.0 65.0 64.0 62.0 74.0 62.0 65.0 66.0 63.0 63.0 17:30:14 INFO - PROCESS | 28325 | -------- Summary: end -------- 17:30:14 INFO - PROCESS | 28325 | 17:30:15 INFO - TEST-INFO | 28325: exit 0 17:30:15 INFO - TEST-OK | kraken | took 65589ms 17:30:15 INFO - SUITE-END | took 1181s 17:30:16 INFO - Completed test suite (00:19:41) 17:30:16 INFO - javascript benchmark 17:30:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7204.81794017455, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3160.5259211118346, 3161.0, 3185.1718553176165, 3200.9039728808116, 3211.2453573410257, 5331.333583302087, 5417.702026388547, 5452.6455780374245, 5505.394406615269, 5518.034343989796, 5354.973225133869, 5382.327209098863, 5387.4073851876365, 5437.619366644337, 5493.313335833021, 240.5947944689584, 4868.780904859272, 4914.778834952435, 4943.8516844494725, 5014.373203349582, 4607.838725644603, 4770.7376094314795, 4862.756862156878, 4887.486813884544, 4901.509849015088, 4898.730569818658, 4907.6073914086965, 4918.065567542156, 4932.014279241839, 4940.851774446773, 4859.07677541266, 4861.314230473702, 4890.608751299887, 4912.70523768575, 4933.851984440473, 4855.83004594841, 4893.1926232171645, 4912.606991440676, 4918.581920536759, 4963.90072198554, 5357.142857142839, 5361.973190134064, 5375.3280839895015, 5408.810691625814, 5416.756245968902, 5640.915386269168, 5681.062624666925, 5690.772369105231, 5825.213596164548, 5868.559858010666, 5781.53747700183, 5841.153032810219, 5847.8538036549, 5869.911951320733, 5912.0, 5428.2671839301975, 5441.619086663935, 5457.317835270591, 5461.863453413656, 5472.534834539069, 5704.486596206279, 5855.443732845373, 5861.589688721834, 5951.702414879239, 5963.075723262901, 5661.490465858093, 5664.575156863251, 5677.489025987681, 5677.886442271214, 5752.0, 5740.1102829061565, 5740.655560666373, 5748.425157484218, 5750.051241545182, 5760.51035661965, 5571.331440227118, 5599.720013999366, 5616.831495055155, 5650.378458369576, 5691.743871525791, 5637.943620563824, 5665.773369065274, 5669.659820410706, 5678.914816277759, 5707.086866101404, 4349.195398851222, 4369.148016136823, 4375.037491751809, 4381.693281470267, 4414.028913638995, 3896.7077469189926, 3900.687944964396, 3908.394198899175, 3928.135810121769, 3965.1276719121747, 5543.77824887, 5545.72271386429, 5546.55627549795, 5590.552755779528, 5618.85952851182, 5874.265716785402, 5875.823725288248, 5880.617759845596, 5881.05903055509, 5895.29256489224, 5487.5884308677005, 5492.368377636543, 5495.725213739377, 5596.2165296858475, 5613.943860561424, 4912.1158191525865, 4954.9752251238515, 4995.075910956485, 5028.19548872186, 5038.798448062036, 5906.409359064145, 5942.584019118706, 5942.910856337158, 5966.552508561788, 5976.043832986701, 5688.687122208318, 5716.142578613241, 5721.370649228665, 5722.6852523109965, 5755.107958266475, 5847.766089356378, 5898.94101058984, 5934.961381758261, 5982.012967860254, 6005.189299444519, 5700.429957004267, 5710.600257981901, 5714.371419143974, 5715.542756579547, 5737.799177028784, 5757.3379061406795, 5807.8548036299435, 5812.808374283177, 5830.2129212555765, 5847.94152058474, 5379.65032272901, 5608.523275521627, 5640.294963129609, 5672.461116193955, 5696.0, 5615.691136987505, 5623.746931388179, 5628.915566266591, 5632.88734225305, 5637.2107904894165, 5414.593905457185, 5554.444555544414, 5570.777168913198, 5572.526335261548, 5585.860353491195, 5674.06377947634, 5698.059820129798, 5702.173184888085, 5773.653580785166, 5776.393478684846, 5593.468620481048, 5604.299462567179, 5615.747291371979, 5627.831165065055, 5630.943690563206], "value": 5290.335175565958, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.390763144487, 634.946029587485, 639.9760383386582, 653.1443808610717, 667.5660820466699, 37605.81197094014, 38589.421158682606, 41665.0, 41796.0, 41895.37156942648, 42499.36250956238, 42842.57259419247, 42871.78564107175, 43137.0, 43239.0, 8652.437591556545, 8838.955805220965, 8854.114588541159, 8855.380123391365, 8874.156955089256, 8732.432391894507, 8790.912090879105, 8824.117588241157, 8864.335174861879, 8867.379283450162, 8860.645574177026, 8880.200781929625, 8893.377463577552, 8928.866067008968, 8945.865812012826, 8659.610317535726, 8715.128487151298, 8824.867626985568, 8851.645934162594, 8878.24534914533, 8716.694915677921, 8791.648334066693, 8813.471191728517, 8830.735077947671, 8841.336899732481, 34180.0, 39195.60804391948, 39660.80169599162, 39714.80142599298, 39759.40360894589, 3043.7260646541918, 3390.728741700683, 3438.914027149316, 3445.8621655133766, 3632.037510059836, 29955.0, 31616.841915790275, 31872.20319492008, 32075.198120046953, 32748.345033099205, 3916.3342231820375, 3935.468711723909, 4005.5193376794678, 4062.410950412174, 4135.048938744106, 299548.0, 300156.0, 301820.0, 302071.0, 304309.0, 36060.81969590135, 36437.0, 36447.63552364495, 36508.81745591308, 36575.4513682295, 35751.82124089363, 36805.0, 36892.262154756754, 38666.80666596705, 38731.2253754929, 16971.236294366783, 17080.0, 17161.399351022654, 17212.311507539558, 17234.82765172332, 12711.68220794469, 12844.935775321064, 12885.806712899313, 12894.742105158031, 12948.287844168473, 19712.802871971384, 20197.293094741908, 20318.695219571717, 20345.89827050855, 20391.18435262573, 7311.23232060626, 7439.218882017419, 7512.737054203077, 7603.543787372775, 7622.199669034782, 903.8056817784208, 985.9852102218473, 990.7176454710373, 1011.2466212671607, 1026.5380578739598, 32285.838570806995, 32999.34001320008, 33012.339753204804, 33028.33943321168, 33322.0, 1113.2374323588367, 1122.3995162587976, 1202.971459402216, 1236.125750310506, 1262.3688155922039, 17144.142792860308, 17610.823891761174, 17788.91105544464, 18442.63114737698, 18815.62368752617, 610850.0, 612221.0, 612383.0, 613455.0, 616110.0, 58835.0, 59668.0, 60111.39888601058, 60420.09369859456, 60711.0, 1342.3959218351781, 1349.2511656030802, 1354.2348573056192, 1356.2540602668494, 1386.895982801294, 31626.841865790524, 33738.493922591675, 33864.0, 33907.15232119217, 34378.48432273468, 52713.0, 52743.47256527539, 53290.46709532855, 53369.466305338006, 53414.465855340946, 486464.0, 489761.0, 491390.0, 495956.0, 496698.0, 28773.424531508834, 28910.421791564473, 29020.419591608472, 29270.121896343142, 29736.25659358447, 48512.27231591458, 49252.2612160825, 49574.256386153516, 49592.504074960234, 50362.49637503578, 42330.576694232666, 42611.3608295882, 42790.0, 43557.78221108874, 43599.56400435955, 41502.792486037375, 42036.0, 42182.578174217866, 42403.575964239964, 42472.57527424686, 38027.2394552113, 40895.591044089175, 41581.37627935644, 41983.0, 42022.78988605038, 33803.4929476063, 35902.820485897406, 36012.27975440529, 36562.0, 36833.63166368302, 27380.863095684395, 27879.442411152068, 27904.44191116207, 27935.580966285117, 28109.297267568476], "value": 19747.065691750588, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.8898319487347, 389.1749491078912, 393.63588680470593, 394.3946042824264, 409.7295784782044, 13578.864211357883, 15172.165530895823, 18008.819911800896, 19660.705089423653, 19712.605747885053, 17365.305387784472, 17856.732149017742, 18718.0, 19221.32725354613, 19863.801361986374, 5691.51622112121, 5810.448007439287, 5847.912281315784, 5909.0, 5942.881142377149, 5622.522085622727, 5740.684262365568, 5789.16057171712, 5830.912536311937, 5832.766689332421, 5733.598648094614, 5752.395998420168, 5755.194272801811, 5768.913466298009, 5771.3074431068335, 5734.455226753452, 5739.512141467981, 5773.538116950634, 5780.913286300709, 5781.19063331134, 5153.948460515385, 5162.974185129088, 5197.8440646780655, 5229.137192363255, 5235.031519168966, 22384.21655242075, 22661.773382266132, 23051.423714407105, 23489.88255058714, 23577.528449431087, 2426.781589656922, 2437.1104546840274, 2494.9875250623813, 2502.4995000999693, 2505.498900219963, 14427.134371937613, 14650.120992740363, 14742.0, 14803.185824779634, 15004.849951500455, 1937.2154277517486, 1956.814102660245, 2000.9995002498752, 2008.0, 2011.7384739983854, 77274.0, 78839.60580197119, 78990.60504697498, 79236.20763792346, 82001.58999204966, 10536.315139515908, 10771.353718776898, 10862.293950893325, 10898.455077246106, 11017.338959662286, 14728.55814325572, 14781.0, 15023.699526009419, 15045.322960466805, 15064.246787660573, 7527.134379546313, 7758.262965018314, 7791.142974272825, 7895.68417263303, 7930.5638189898955, 7279.963600181965, 7357.117145942521, 7446.925530744732, 7487.812804679927, 7523.435742319348, 6593.571417857824, 6728.293529179464, 6730.293319201512, 6775.796726098225, 6940.479464040217, 1904.7238150468104, 1944.6110777844488, 1946.2701486942397, 1953.6092781443767, 1957.2464601128383, 916.7891384981358, 1041.8489319048695, 1080.9513571889127, 1094.0809719835377, 1129.491728722062, 19423.611527769364, 20018.59962800736, 20138.798612013692, 20271.0, 20387.388378348674, 1014.9898501014895, 1020.6835880876952, 1045.3780000899453, 1045.581767293089, 1073.1951036722458, 10418.166546676248, 11359.716007099723, 11420.37187954654, 11551.884481155248, 11631.185816992898, 485325.0, 489573.0, 490254.0, 492524.0, 492612.0, 71621.64189179125, 99415.50292248493, 101147.49426252821, 101734.49132754288, 102696.48651756694, 1001.6544292219173, 1039.0285083447002, 1049.0191670787838, 1050.5430137890041, 1054.1935419404163, 17694.380696675555, 17844.643107138043, 18028.828126171757, 18281.908590456962, 18471.90764046225, 31953.68046319507, 38698.03254918649, 40863.0, 42527.0, 43661.34507982319, 59756.0, 60240.397596025236, 61629.691851540454, 61862.69068654628, 62280.75438491114, 8853.73438796837, 8907.910920890708, 8993.955030224806, 9010.729678109667, 9224.861627075734, 9479.715608531755, 10550.788984220426, 12429.627111186317, 12500.312482813533, 12718.554850580185, 10872.402017889091, 10892.128629709447, 11044.392558409365, 11192.2700293771, 11197.66407007791, 10022.047905448972, 10805.729856753644, 11067.335959842436, 11106.555737770399, 11141.498632561716, 11172.273802202832, 11355.318680879174, 11377.886221137682, 11430.371329576621, 11446.37044962535, 8762.561871906251, 8962.955185224033, 9014.459132452073, 9050.094990500897, 9105.226055785333, 10234.488275586042, 10329.896701032894, 10701.357918524913, 10856.34861908288, 11444.94277528607], "value": 9335.967026436947, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.7729963205886, 1454.0112723348122, 1545.6213227759195, 1660.7591899174613, 1686.2243368050697, 7501.924980750191, 8277.255047045765, 8367.121452247502, 8874.77813054673, 8887.555622218888, 8522.40343175978, 8798.472091674505, 8801.075887031866, 8809.427387219826, 8850.114988501147, 2323.9767602323973, 2328.871912044837, 2368.0291080656934, 2368.9339797091293, 2369.0168580039262, 2276.6926464927187, 2286.8856557172157, 2317.5017371265176, 2323.2797832671927, 2343.7070366204225, 2308.1575225042907, 2323.465602911331, 2337.2053501809382, 2337.777911098443, 2348.236823032513, 2243.7868402501817, 2298.1152256381247, 2315.6642286868478, 2324.7675232476786, 2331.393837602227, 2255.4699645583273, 2279.974011694744, 2283.8515496492673, 2286.371247906822, 2304.43541332373, 8757.343199260082, 8826.470411775314, 8896.332775041898, 8896.510691911943, 8929.062448442884, 5069.847904562869, 5135.743212839343, 5168.767405466763, 5177.974110129463, 5227.372715274191, 3063.3107550801114, 3194.472911969522, 3250.0574833298315, 3268.7221586165206, 3275.8525866335835, 1090.983635245472, 1100.7028102412303, 1124.3478782306324, 1129.13056946151, 1134.6425875849081, 12063.155579109465, 12087.395630218542, 12241.93879030608, 12311.19977201488, 12331.0, 4379.343098535245, 4443.178012067713, 4509.255972764523, 4530.139273538083, 4535.138323718483, 10274.589016439408, 10338.172946164288, 10367.429791361548, 10388.636397726043, 10498.055175034284, 5116.130257856174, 5123.129068058439, 5127.743612819344, 5130.050940576006, 5131.974340128276, 4156.605122513356, 4575.3823233863, 4650.67445278834, 4707.129181101507, 4720.45714742809, 3750.7374483785875, 3852.7110466715108, 3890.0469385000856, 3958.762474251554, 4080.81636326366, 1250.7748605251143, 1255.7614053329837, 1256.5225214418645, 1268.7018550640591, 1279.1941077121353, 819.4591569564178, 882.7660669922476, 924.3437159616612, 930.8371035068972, 946.8816397950256, 5782.306123265235, 5794.072948328248, 5816.360200377955, 5898.14476900847, 6106.2061931948565, 455.79944824277874, 466.2609763524851, 475.9833405830779, 480.58909632264607, 481.480001598273, 3844.2695887781792, 4069.9796501017304, 4114.0948991221885, 4138.985948442651, 4145.336746120606, 10477.84283235752, 10651.520681569347, 10686.0, 10788.298760580537, 10803.729906752395, 10187.337823041478, 10562.31344962575, 10568.313059651098, 10587.735306617242, 10676.839847402296, 7977.122516523178, 8160.795980100545, 8176.305014073751, 8218.424710270223, 8236.588170591447, 5746.597738158289, 6066.332703402711, 6077.574569780073, 6083.0, 6191.4118158774845, 9589.136977672042, 10067.69796906094, 10076.94961525217, 10236.436995965294, 10255.641052563124, 10119.241056920613, 10130.898691012995, 10137.543810528692, 10249.0, 10255.94872025635, 7043.0, 7547.5848828314965, 7820.608969551614, 7839.568823714522, 7919.881201781863, 8656.523891185794, 8661.653533858575, 8683.522406267715, 8722.651093956425, 8746.037935826927, 7738.458307918617, 7791.727289544839, 7896.131425543301, 8023.919760802317, 8039.437239393186, 7642.312191902755, 7663.8850417242675, 7717.57553334572, 7798.0, 7813.570253636105, 6843.144606924135, 6913.41235994926, 6929.89605155913, 6937.7571784987285, 6949.617771022642, 4716.64625153108, 4967.031428871335, 5093.2105523643895, 5114.897702045864, 5206.791728330824, 5188.22176673502, 5237.973810130925, 5279.419263880894, 5303.893922121459, 5327.493888080626], "value": 4506.867143898496, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.50153256322426, 325.8028892520026, 327.9195052302664, 329.9340131973605, 333.8747969511433, 5577.888442231153, 5653.643125649845, 5657.151427285909, 5689.914651280229, 5771.711414429272, 5619.353774315955, 5637.718114094289, 5661.264035675366, 5670.0927851543765, 5680.772769089232, 4346.739195648272, 4349.999000459792, 4382.496012958519, 4385.451818522684, 4392.758398288093, 4276.909388106029, 4391.0, 4394.07724377881, 4414.646828253732, 4414.757188354639, 4319.719218250803, 4347.652187824967, 4362.5637436256275, 4377.190219809346, 4379.693421460499, 4376.6936314458, 4378.321360189176, 4407.911841763147, 4408.7575183365225, 4419.099787091549, 3617.385044542434, 3810.866619668326, 3850.1337199130253, 3860.1314704191614, 3864.3623802072625, 5424.484673955968, 5475.342958844924, 5501.449855014466, 5517.806876759334, 5542.4457554244655, 4896.779644915951, 4922.237053256715, 4947.777350019258, 4975.4527002029745, 5015.32293140425, 5498.642588231752, 5778.27771528559, 5881.323647780518, 5895.941040589582, 5899.970500147515, 4012.177503611782, 4023.3562629979356, 4030.7984600769846, 4059.939100913489, 4075.7962101894786, 5994.220751302347, 6146.29317628474, 6163.383661633846, 6179.752809887599, 6191.0, 4234.767087810138, 4245.363195520635, 4255.6169944705125, 4259.488861336659, 4264.891128306663, 4293.205756934977, 4295.398644189816, 4347.1740369330355, 4356.324769660708, 4372.278574035312, 4843.297721830315, 4936.259561065869, 4949.529794669501, 4954.405471343462, 4972.632526055291, 5923.585349025527, 5967.224260846062, 5968.940310596839, 5995.61028533144, 6046.18376519173, 1442.7619442791822, 1462.1738717624507, 1463.8097047383771, 1463.9560813175622, 1467.325030485967, 921.9815603688023, 943.3396622364372, 950.847864341702, 957.2581249531669, 971.7998272133909, 5113.258577506241, 5121.308623335876, 5152.355955505562, 5198.454162312903, 5217.9478205217465, 5365.195220716923, 5400.864978375494, 5467.234587157801, 5482.588805839578, 5520.254765606672, 4930.207006767035, 5205.895882082337, 5212.166053431509, 5217.556507696889, 5243.475652434726, 2871.956920646192, 2890.7976441648884, 2908.927276818054, 2949.675535691072, 2950.3066779306846, 5537.363203231599, 5601.467860553241, 5629.296337957755, 5648.85877853057, 5664.376918538957, 5141.584536558061, 5369.7583608737705, 5383.488568585978, 5436.565074794007, 5479.904019196177, 5500.4499550045475, 5561.860953476195, 5612.242347283146, 5631.831045068655, 5642.181883626851, 5230.712310822942, 5232.770298979813, 5385.92281543685, 5395.919061214164, 5397.299850547222, 5308.681479111266, 5311.973440132774, 5358.705271210121, 5380.623356365017, 5395.163749618815, 5997.5501837363245, 6114.174586430775, 6275.435210831047, 6355.72885422908, 6375.904361434675, 4366.912661746684, 4408.861702074427, 4421.646268298464, 4423.469183697848, 4424.225760491965, 5808.332041815245, 6039.4262545058145, 6080.7567697291615, 6122.44897959168, 6143.938560614337, 5889.882202356014, 5922.881542369215, 5934.821955341346, 5951.7619295227705, 5964.7912323068485, 5873.295204575478, 5876.559258055749, 5949.672767997628, 5954.3152537458745, 5979.402059793986, 5651.547876169979, 5811.389804070681, 5825.533957283492, 5841.561882858718, 5855.648661080349, 5891.0, 5928.8814223716145, 5954.3152537458745, 6000.549958753199, 6038.426349496791, 5741.540676745767, 5746.42535746422, 5768.826935191951, 5846.473817356288, 5868.327526654883], "value": 4356.163441835646, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.4010711216803, 757.7310054930499, 771.3173841150583, 778.5834578500502, 779.9337056350209, 14842.183679897602, 15675.843241567582, 15757.763633545492, 15778.842211577881, 15815.367385304575, 14850.702985940276, 14962.32669529871, 14991.325390357433, 15000.324985375657, 15013.699726005474, 654.9410553050225, 782.4131901074194, 790.4861839804116, 808.8422757562278, 813.2152472863685, 791.9406044546653, 796.9760907172794, 798.6406117247233, 798.8042929482285, 799.5802203843, 848.6605357856845, 852.0797538658235, 853.1212850763692, 854.6325080215505, 854.9102344253826, 848.9702860399888, 850.056437354536, 850.2772643253247, 850.4174640371334, 852.211704173643, 610.5420934299276, 612.9172561704157, 617.0743884173739, 617.0928734759896, 619.7830759234276, 14708.852911470962, 14752.40990360395, 14760.48338308154, 14771.113733176044, 14914.776278355834, 14012.71974560503, 14191.290435478288, 14239.430422783076, 14257.215853128073, 14369.281535923163, 12124.151309408346, 12148.45331960055, 12269.93865030678, 12304.446299916435, 12343.259404435763, 3874.438206460076, 4073.9388909166387, 4079.1433798902267, 4125.8968525786795, 4132.359484279941, 80958.20895522447, 81089.18910810875, 81485.59257203677, 81547.5922620389, 82215.0, 10279.17766578672, 10372.170226381872, 10428.687139385831, 10506.951956967143, 10636.042756151828, 22031.779682203294, 22055.779442205694, 22066.66899996501, 22068.2276120335, 22072.558548828933, 8110.148434414419, 8114.0, 8321.334293256525, 8343.123971982975, 8359.540225287546, 4537.727736335831, 4665.9766701166955, 4712.31671407644, 4728.550787675165, 4790.808367665324, 3227.193201699575, 3296.604407471119, 3320.66793320666, 3337.983310083434, 3382.9323413531592, 600.2107228993947, 604.3231580629723, 609.5306613907267, 620.2371083567148, 621.8818424499331, 607.614165005216, 627.9529035322369, 679.7281087564915, 708.0794966543473, 740.0822979505375, 8515.48907065578, 8767.430117042371, 9042.954785226031, 9276.675316363895, 9443.669471568599, 578.2396149063967, 626.9936751513845, 649.3344322069822, 663.1942190238883, 675.4022689919457, 4101.630853223224, 4292.068309679845, 4357.586029327209, 4392.2094023075515, 4470.374147619336, 71099.28900710927, 71946.28053719501, 95529.5223523878, 96677.51661241648, 99320.50339748255, 96587.0, 97576.51211743896, 98116.0, 99228.0, 99776.0, 56766.432335676116, 65540.67229663917, 88751.55624221837, 89895.0, 91327.5433622841, 9009.909900900908, 9467.072460014126, 9548.331616787036, 9560.303761137067, 9736.318457708176, 44370.556294437934, 47602.28596570985, 49508.50491495183, 50001.0, 50054.499455006444, 48852.5114748848, 50854.23718644297, 67165.0, 68647.65676171587, 73959.0, 12234.224667920646, 12346.3826808661, 12515.311657858905, 12524.185927914656, 12560.806723361266, 13573.253471058792, 13587.59237222885, 14135.0, 14162.656568019003, 15088.094714317176, 12908.0, 13028.348582570645, 13266.933665331611, 13566.186028838301, 13674.521391751241, 13062.673433163867, 13169.47322107105, 13988.0, 14057.644596254291, 14253.572392828231, 12441.066919980856, 12840.101192916407, 13541.1198272112, 13681.452741890213, 14437.989340746048, 10647.787044259227, 10835.295705779099, 10955.178361622751, 11067.280626759235, 11658.6502404928, 10598.31110977784, 10737.516811743333, 10766.623168189075, 11059.72350691239, 11064.114870810155], "value": 7304.14921437541, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 105.0, 109.0, 112.0, 113.0, 114.0, 111.0, 112.0, 113.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 129.0, 154.0, 179.0, 128.0, 155.0, 151.0, 127.0, 185.0, 126.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 164.0, 162.0, 165.0, 170.0, 162.0, 166.0, 162.0, 164.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 155.0, 77.0, 76.0, 75.0, 76.0, 158.0, 76.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 144.0, 85.0, 85.0, 86.0, 153.0, 86.0, 86.0, 151.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 148.0, 150.0, 148.0, 149.0, 148.0, 148.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 55.0, 59.0, 55.0, 55.0, 55.0, 56.0, 54.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 61.0, 62.0, 62.0, 61.0, 61.0, 63.0, 62.0, 63.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 78.0, 78.0, 85.0, 83.0, 88.0, 79.0, 81.0, 88.0, 80.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 123.0, 134.0, 128.0, 129.0, 139.0, 126.0, 145.0, 128.0, 135.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 170.0, 162.0, 157.0, 161.0, 158.0, 165.0, 164.0, 162.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 62.0, 74.0, 62.0, 65.0, 66.0, 63.0, 63.0], "value": 64.8, "unit": "score"}]}]} 17:30:16 INFO - Return code: 0 17:30:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:30:16 ERROR - # TBPL SUCCESS # 17:30:16 INFO - Running post-action listener: _resource_record_post_action 17:30:16 INFO - ##### 17:30:16 INFO - ##### Finished run-tests step (success) 17:30:16 INFO - ##### 17:30:16 INFO - Running post-run listener: _resource_record_post_run 17:30:16 INFO - Total resource usage - Wall time: 1207s; CPU: 14.0%; Read bytes: 4096; Write bytes: 557170688; Read time: 8; Write time: 3844548 17:30:16 INFO - TinderboxPrint: CPU usage
14.0% 17:30:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 17:30:16 INFO - TinderboxPrint: I/O write bytes / time
557,170,688 / 3,844,548 17:30:16 INFO - TinderboxPrint: CPU idle
8,281.3 (86.0%) 17:30:16 INFO - TinderboxPrint: CPU user
1,230.8 (12.8%) 17:30:16 INFO - TinderboxPrint: Swap in / out
0 / 0 17:30:16 INFO - install - Wall time: 24s; CPU: 27.0%; Read bytes: 0; Write bytes: 259428352; Read time: 0; Write time: 2555952 17:30:16 INFO - run-tests - Wall time: 1183s; CPU: 14.0%; Read bytes: 4096; Write bytes: 294653952; Read time: 8; Write time: 1269400 17:30:17 INFO - Running post-run listener: _upload_blobber_files 17:30:17 INFO - Blob upload gear active. 17:30:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:30:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:30:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:30:17 INFO - (blobuploader) - INFO - Open directory for files ... 17:30:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:30:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:30:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:21 INFO - (blobuploader) - INFO - Done attempting. 17:30:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:30:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:30:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:22 INFO - (blobuploader) - INFO - Done attempting. 17:30:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:30:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:30:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:23 INFO - (blobuploader) - INFO - Done attempting. 17:30:23 INFO - (blobuploader) - INFO - Iteration through files over. 17:30:23 INFO - Return code: 0 17:30:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:30:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:30:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae070a735b5bbf47e9bb792a4a94675b4c4a5a7f12e658e7893ba5b6ce1b897a5180290d83f99761650c92095a1ecf2f0061a1df5c9fcb74443468131d5a7366", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea4f5d63d75f07d76665990053938df9e8767a1a2ac3a573331e3f9122784b5dde3f4fa145b494a21fe9848e4f97e3bb8b506513c95b8155b917921496ab1cde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5611559d0509923daebc21ab4096d3ee5dead81317f042dd69ea001e77ac91d5f264eb94c831a7e603e16e0f383607473a1226a5125d6a3e13f3e9144e5e1c70"} 17:30:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:30:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:30:23 INFO - Contents: 17:30:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae070a735b5bbf47e9bb792a4a94675b4c4a5a7f12e658e7893ba5b6ce1b897a5180290d83f99761650c92095a1ecf2f0061a1df5c9fcb74443468131d5a7366", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea4f5d63d75f07d76665990053938df9e8767a1a2ac3a573331e3f9122784b5dde3f4fa145b494a21fe9848e4f97e3bb8b506513c95b8155b917921496ab1cde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5611559d0509923daebc21ab4096d3ee5dead81317f042dd69ea001e77ac91d5f264eb94c831a7e603e16e0f383607473a1226a5125d6a3e13f3e9144e5e1c70"} 17:30:23 INFO - Running post-run listener: copy_logs_to_upload_dir 17:30:23 INFO - Copying logs to upload dir... 17:30:23 INFO - mkdir: /builds/slave/test/build/upload/logs 17:30:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.877527 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-22 17:30:22.122297) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 17:30:22.125977) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae070a735b5bbf47e9bb792a4a94675b4c4a5a7f12e658e7893ba5b6ce1b897a5180290d83f99761650c92095a1ecf2f0061a1df5c9fcb74443468131d5a7366", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea4f5d63d75f07d76665990053938df9e8767a1a2ac3a573331e3f9122784b5dde3f4fa145b494a21fe9848e4f97e3bb8b506513c95b8155b917921496ab1cde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5611559d0509923daebc21ab4096d3ee5dead81317f042dd69ea001e77ac91d5f264eb94c831a7e603e16e0f383607473a1226a5125d6a3e13f3e9144e5e1c70"} build_url:https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/PfwDuhOdQMSp_Fo2hT4gXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae070a735b5bbf47e9bb792a4a94675b4c4a5a7f12e658e7893ba5b6ce1b897a5180290d83f99761650c92095a1ecf2f0061a1df5c9fcb74443468131d5a7366", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea4f5d63d75f07d76665990053938df9e8767a1a2ac3a573331e3f9122784b5dde3f4fa145b494a21fe9848e4f97e3bb8b506513c95b8155b917921496ab1cde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5611559d0509923daebc21ab4096d3ee5dead81317f042dd69ea001e77ac91d5f264eb94c831a7e603e16e0f383607473a1226a5125d6a3e13f3e9144e5e1c70"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 17:30:22.152153) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:30:22.152485) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1466640353.172875-126286790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004646 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:30:22.234417) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 17:30:22.234795) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 17:30:22.235152) ========= ========= Total master_lag: 0.39 =========