builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1465161797.68 results: success (0) buildid: 20160605113024 builduid: 217a6c9b3ca74f588626834858db16d4 revision: f42a04d822baa22a4741c4fff1aab2054857e398 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 14:23:17.678465) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 14:23:17.679162) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 14:23:17.679479) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 14:23:17.697575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 14:23:17.697884) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-05 14:23:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-06-05 14:23:17 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129672 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 14:23:17.847696) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 14:23:17.847981) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017993 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 14:23:17.909182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 14:23:17.909546) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f42a04d822baa22a4741c4fff1aab2054857e398 --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 f42a04d822baa22a4741c4fff1aab2054857e398 --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=e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-05 14:23:17,990 truncating revision to first 12 chars 2016-06-05 14:23:17,990 Setting DEBUG logging. 2016-06-05 14:23:17,990 attempt 1/10 2016-06-05 14:23:17,990 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f42a04d822ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-05 14:23:18,446 unpacking tar archive at: fx-team-f42a04d822ba/testing/mozharness/ program finished with exit code 0 elapsedTime=0.804514 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 14:23:18.733540) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 14:23:18.733836) ========= script_repo_revision: f42a04d822baa22a4741c4fff1aab2054857e398 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 14:23:18.734281) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 14:23:18.734574) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 14:23:18.744808) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-05 14:23:18.745098) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:23:18 INFO - MultiFileLogger online at 20160605 14:23:18 in /builds/slave/test 14:23:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:23:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:23:18 INFO - {'append_to_log': False, 14:23:18 INFO - 'base_work_dir': '/builds/slave/test', 14:23:18 INFO - 'blob_upload_branch': 'Fx-Team', 14:23:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:23:18 INFO - 'branch': 'Fx-Team', 14:23:18 INFO - 'buildbot_json_path': 'buildprops.json', 14:23:18 INFO - 'config_files': ('talos/linux_config.py',), 14:23:18 INFO - 'default_actions': ('clobber', 14:23:18 INFO - 'read-buildbot-config', 14:23:18 INFO - 'download-and-extract', 14:23:18 INFO - 'populate-webroot', 14:23:18 INFO - 'create-virtualenv', 14:23:18 INFO - 'install', 14:23:18 INFO - 'run-tests'), 14:23:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:23:18 INFO - 'download_minidump_stackwalk': True, 14:23:18 INFO - 'download_symbols': 'ondemand', 14:23:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:23:18 INFO - 'tooltool.py': '/tools/tooltool.py', 14:23:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:23:18 INFO - '/tools/misc-python/virtualenv.py')}, 14:23:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:23:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:23:18 INFO - 'installer_path': 'installer.exe', 14:23:18 INFO - 'log_level': 'info', 14:23:18 INFO - 'log_name': 'talos', 14:23:18 INFO - 'log_to_console': True, 14:23:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:23:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:23:18 INFO - 'opt_config_files': (), 14:23:18 INFO - 'pip_index': False, 14:23:18 INFO - 'sps_profile': False, 14:23:18 INFO - 'sps_profile_interval': 0, 14:23:18 INFO - 'suite': 'dromaeojs', 14:23:18 INFO - 'system_bits': '32', 14:23:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:23:18 INFO - 'title': 'talos-linux64-ix-006', 14:23:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:23:18 INFO - 'use_talos_json': True, 14:23:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:23:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:23:18 INFO - 'work_dir': 'build'} 14:23:18 INFO - ##### 14:23:18 INFO - ##### Running clobber step. 14:23:18 INFO - ##### 14:23:18 INFO - Running pre-action listener: _resource_record_pre_action 14:23:18 INFO - Running main action method: clobber 14:23:18 INFO - rmtree: /builds/slave/test/build 14:23:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:23:19 INFO - Running post-action listener: _resource_record_post_action 14:23:19 INFO - ##### 14:23:19 INFO - ##### Finished clobber step (success) 14:23:19 INFO - ##### 14:23:19 INFO - ##### 14:23:19 INFO - ##### Running read-buildbot-config step. 14:23:19 INFO - ##### 14:23:19 INFO - Running pre-action listener: _resource_record_pre_action 14:23:19 INFO - Running main action method: read_buildbot_config 14:23:19 INFO - Using buildbot properties: 14:23:19 INFO - { 14:23:19 INFO - "project": "", 14:23:19 INFO - "product": "firefox", 14:23:19 INFO - "script_repo_revision": "production", 14:23:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:23:19 INFO - "repository": "", 14:23:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:23:19 INFO - "buildid": "20160605113024", 14:23:19 INFO - "pgo_build": "True", 14:23:19 INFO - "basedir": "/builds/slave/test", 14:23:19 INFO - "buildnumber": 157, 14:23:19 INFO - "slavename": "talos-linux64-ix-006", 14:23:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:23:19 INFO - "platform": "ubuntu64_hw", 14:23:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:23:19 INFO - "branch": "fx-team", 14:23:19 INFO - "repo_path": "integration/fx-team", 14:23:19 INFO - "revision": "f42a04d822baa22a4741c4fff1aab2054857e398", 14:23:19 INFO - "stage_platform": "linux64-pgo", 14:23:19 INFO - "builduid": "217a6c9b3ca74f588626834858db16d4", 14:23:19 INFO - "slavebuilddir": "test" 14:23:19 INFO - } 14:23:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:23:19 INFO - Running post-action listener: _resource_record_post_action 14:23:19 INFO - ##### 14:23:19 INFO - ##### Finished read-buildbot-config step (success) 14:23:19 INFO - ##### 14:23:19 INFO - ##### 14:23:19 INFO - ##### Running download-and-extract step. 14:23:19 INFO - ##### 14:23:19 INFO - Running pre-action listener: _resource_record_pre_action 14:23:19 INFO - Running main action method: download_and_extract 14:23:19 INFO - mkdir: /builds/slave/test/build/tests 14:23:19 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')]} 14:23:19 INFO - https://queue.taskcluster.net/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:23:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:23:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:23:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:23:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:23:26 INFO - Downloaded 1361 bytes. 14:23:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:23:26 INFO - Using the following test package requirements: 14:23:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:23:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:23:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:23:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:23:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:23:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:23:26 INFO - u'jsshell-linux-x86_64.zip'], 14:23:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:23:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:23:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:23:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:23:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:23:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:23:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:23:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:23:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:23:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:23:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:23:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:23: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')]} 14:23:26 INFO - https://queue.taskcluster.net/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:23:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:23:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:23:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:23:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:23:31 INFO - Downloaded 24440907 bytes. 14:23:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:23:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:23:33 INFO - Return code: 0 14:23:33 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:23: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')]} 14:23:33 INFO - https://queue.taskcluster.net/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:23:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:23:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:23:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:23:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:23:36 INFO - Downloaded 24440907 bytes. 14:23:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:23:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:23:37 INFO - Return code: 0 14:23:37 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')]} 14:23:37 INFO - https://queue.taskcluster.net/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:23:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:23:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:23:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:23:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:23:38 INFO - Downloaded 10833369 bytes. 14:23:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:23:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:23:38 INFO - Return code: 0 14:23:38 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')]} 14:23:38 INFO - https://queue.taskcluster.net/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:23:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:23:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:23:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:23:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:23:40 INFO - Downloaded 59138690 bytes. 14:23:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:23:40 INFO - mkdir: /builds/slave/test/properties 14:23:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:23:40 INFO - Writing to file /builds/slave/test/properties/build_url 14:23:40 INFO - Contents: 14:23:40 INFO - build_url:https://queue.taskcluster.net/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:23:41 INFO - Running post-action listener: _resource_record_post_action 14:23:41 INFO - Running post-action listener: set_extra_try_arguments 14:23:41 INFO - ##### 14:23:41 INFO - ##### Finished download-and-extract step (success) 14:23:41 INFO - ##### 14:23:41 INFO - ##### 14:23:41 INFO - ##### Running populate-webroot step. 14:23:41 INFO - ##### 14:23:41 INFO - Running pre-action listener: _resource_record_pre_action 14:23:41 INFO - Running main action method: populate_webroot 14:23:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:23:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:23:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:23:41 INFO - '--tppagecycles', 14:23:41 INFO - '7'], 14:23:41 INFO - 'tests': ['tsvgm']}}, 14:23:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:23:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:23:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:23:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:23:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:23:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:23:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:41 INFO - 'talos_options': ['--disable-e10s'], 14:23:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:41 INFO - 'talos_options': ['--disable-e10s'], 14:23:41 INFO - 'tests': ['damp', 'tps']}, 14:23:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:41 INFO - 'tests': ['damp', 'tps']}, 14:23:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:23:41 INFO - 'tests': ['dromaeo_dom']}, 14:23:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:23:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:23:41 INFO - 'tests': ['a11yr', 14:23:41 INFO - 'ts_paint', 14:23:41 INFO - 'tpaint', 14:23:41 INFO - 'sessionrestore', 14:23:41 INFO - 'sessionrestore_no_auto_restore', 14:23:41 INFO - 'tabpaint']}, 14:23:41 INFO - 'other-e10s': {'tests': ['a11yr', 14:23:41 INFO - 'ts_paint', 14:23:41 INFO - 'tpaint', 14:23:41 INFO - 'sessionrestore', 14:23:41 INFO - 'sessionrestore_no_auto_restore', 14:23:41 INFO - 'tabpaint']}, 14:23:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:23:41 INFO - 'ts_paint', 14:23:41 INFO - 'tpaint', 14:23:41 INFO - 'sessionrestore', 14:23:41 INFO - 'sessionrestore_no_auto_restore', 14:23:41 INFO - 'tabpaint']}, 14:23:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:23:41 INFO - 'ts_paint', 14:23:41 INFO - 'tpaint', 14:23:41 INFO - 'sessionrestore', 14:23:41 INFO - 'sessionrestore_no_auto_restore', 14:23:41 INFO - 'tabpaint']}, 14:23:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:23:41 INFO - 'tests': ['a11yr', 14:23:41 INFO - 'ts_paint', 14:23:41 INFO - 'tpaint', 14:23:41 INFO - 'sessionrestore', 14:23:41 INFO - 'sessionrestore_no_auto_restore', 14:23:41 INFO - 'tabpaint']}, 14:23:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:23:41 INFO - 'tests': ['a11yr', 14:23:41 INFO - 'ts_paint', 14:23:41 INFO - 'tpaint', 14:23:41 INFO - 'sessionrestore', 14:23:41 INFO - 'sessionrestore_no_auto_restore', 14:23:41 INFO - 'tabpaint']}, 14:23:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:23:41 INFO - 'tests': ['tsvgx', 14:23:41 INFO - 'tsvgr_opacity', 14:23:41 INFO - 'tart', 14:23:41 INFO - 'tscrollx', 14:23:41 INFO - 'cart']}, 14:23:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:23:41 INFO - 'tsvgr_opacity', 14:23:41 INFO - 'tart', 14:23:41 INFO - 'tscrollx', 14:23:41 INFO - 'cart']}, 14:23:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:41 INFO - 'talos_options': ['--disable-e10s'], 14:23:41 INFO - 'tests': ['tp5o']}, 14:23:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:41 INFO - 'tests': ['tp5o']}, 14:23:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:41 INFO - 'talos_options': ['--disable-e10s', 14:23:41 INFO - '--xperf_path', 14:23:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:41 INFO - 'tests': ['tp5n']}, 14:23:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:41 INFO - 'talos_options': ['--xperf_path', 14:23:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:41 INFO - 'tests': ['tp5n']}}, 14:23:41 INFO - 'talos.zip': {'path': '', 14:23:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:23:41 INFO - Running post-action listener: _resource_record_post_action 14:23:41 INFO - ##### 14:23:41 INFO - ##### Finished populate-webroot step (success) 14:23:41 INFO - ##### 14:23:41 INFO - ##### 14:23:41 INFO - ##### Running create-virtualenv step. 14:23:41 INFO - ##### 14:23:41 INFO - Running pre-action listener: _resource_record_pre_action 14:23:41 INFO - Running main action method: create_virtualenv 14:23:41 INFO - Creating virtualenv /builds/slave/test/build/venv 14:23:41 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 14:23:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:23:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:23:41 INFO - Using real prefix '/usr' 14:23:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:23:41 INFO - Installing distribute.............................................................................................................................................................................................done. 14:23:43 INFO - Installing pip.................done. 14:23:43 INFO - Return code: 0 14:23:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:23:43 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')]} 14:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:43 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')]} 14:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:43 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 0x7f0286b3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2733350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c21c0>, '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 0x27c30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c3550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', '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 14:23:43 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 14:23:43 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 14:23:43 INFO - Using env: {'DISPLAY': ':0', 14:23:43 INFO - 'HOME': '/home/cltbld', 14:23:43 INFO - 'LANG': 'en_US.UTF-8', 14:23:43 INFO - 'LANGUAGE': 'en_US:en', 14:23:43 INFO - 'LOGNAME': 'cltbld', 14:23:43 INFO - 'MAIL': '/var/mail/cltbld', 14:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:43 INFO - 'MOZ_NO_REMOTE': '1', 14:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:43 INFO - 'NO_EM_RESTART': '1', 14:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:43 INFO - 'PWD': '/builds/slave/test', 14:23:43 INFO - 'SHELL': '/bin/bash', 14:23:43 INFO - 'SHLVL': '1', 14:23:43 INFO - 'TERM': 'linux', 14:23:43 INFO - 'TMOUT': '86400', 14:23:43 INFO - 'USER': 'cltbld', 14:23:43 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', 14:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:43 INFO - '_': '/tools/buildbot/bin/python'} 14:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:44 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 14:23:44 INFO - Cleaning up... 14:23:44 INFO - Return code: 0 14:23:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:23:44 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')]} 14:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:44 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')]} 14:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:44 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 0x7f0286b3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2733350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c21c0>, '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 0x27c30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c3550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', '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 14:23:44 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 14:23:44 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 14:23:44 INFO - Using env: {'DISPLAY': ':0', 14:23:44 INFO - 'HOME': '/home/cltbld', 14:23:44 INFO - 'LANG': 'en_US.UTF-8', 14:23:44 INFO - 'LANGUAGE': 'en_US:en', 14:23:44 INFO - 'LOGNAME': 'cltbld', 14:23:44 INFO - 'MAIL': '/var/mail/cltbld', 14:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:44 INFO - 'MOZ_NO_REMOTE': '1', 14:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:44 INFO - 'NO_EM_RESTART': '1', 14:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:44 INFO - 'PWD': '/builds/slave/test', 14:23:44 INFO - 'SHELL': '/bin/bash', 14:23:44 INFO - 'SHLVL': '1', 14:23:44 INFO - 'TERM': 'linux', 14:23:44 INFO - 'TMOUT': '86400', 14:23:44 INFO - 'USER': 'cltbld', 14:23:44 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', 14:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:44 INFO - '_': '/tools/buildbot/bin/python'} 14:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:44 INFO - Downloading/unpacking psutil>=3.1.1 14:23:44 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 14:23:44 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 14:23:44 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 14:23:44 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 14:23:44 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 14:23:44 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 14:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:23:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:23:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:23:46 INFO - Installing collected packages: psutil 14:23:46 INFO - Running setup.py install for psutil 14:23:46 INFO - building 'psutil._psutil_linux' extension 14:23:46 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 14:23:46 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 14:23:46 INFO - building 'psutil._psutil_posix' extension 14:23:46 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 14:23:46 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 14:23:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:23:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:23:46 INFO - Successfully installed psutil 14:23:46 INFO - Cleaning up... 14:23:47 INFO - Return code: 0 14:23:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:23:47 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')]} 14:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:47 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')]} 14:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:47 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 0x7f0286b3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2733350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c21c0>, '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 0x27c30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c3550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', '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 14:23:47 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 14:23:47 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 14:23:47 INFO - Using env: {'DISPLAY': ':0', 14:23:47 INFO - 'HOME': '/home/cltbld', 14:23:47 INFO - 'LANG': 'en_US.UTF-8', 14:23:47 INFO - 'LANGUAGE': 'en_US:en', 14:23:47 INFO - 'LOGNAME': 'cltbld', 14:23:47 INFO - 'MAIL': '/var/mail/cltbld', 14:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:47 INFO - 'MOZ_NO_REMOTE': '1', 14:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:47 INFO - 'NO_EM_RESTART': '1', 14:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:47 INFO - 'PWD': '/builds/slave/test', 14:23:47 INFO - 'SHELL': '/bin/bash', 14:23:47 INFO - 'SHLVL': '1', 14:23:47 INFO - 'TERM': 'linux', 14:23:47 INFO - 'TMOUT': '86400', 14:23:47 INFO - 'USER': 'cltbld', 14:23:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', 14:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:47 INFO - '_': '/tools/buildbot/bin/python'} 14:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:23:49 INFO - Installing collected packages: mozsystemmonitor 14:23:49 INFO - Running setup.py install for mozsystemmonitor 14:23:49 INFO - Successfully installed mozsystemmonitor 14:23:49 INFO - Cleaning up... 14:23:50 INFO - Return code: 0 14:23:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:23:50 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')]} 14:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:50 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')]} 14:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:50 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 0x7f0286b3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2733350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c21c0>, '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 0x27c30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c3550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', '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 14:23:50 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 14:23:50 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 14:23:50 INFO - Using env: {'DISPLAY': ':0', 14:23:50 INFO - 'HOME': '/home/cltbld', 14:23:50 INFO - 'LANG': 'en_US.UTF-8', 14:23:50 INFO - 'LANGUAGE': 'en_US:en', 14:23:50 INFO - 'LOGNAME': 'cltbld', 14:23:50 INFO - 'MAIL': '/var/mail/cltbld', 14:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:50 INFO - 'MOZ_NO_REMOTE': '1', 14:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:50 INFO - 'NO_EM_RESTART': '1', 14:23:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:50 INFO - 'PWD': '/builds/slave/test', 14:23:50 INFO - 'SHELL': '/bin/bash', 14:23:50 INFO - 'SHLVL': '1', 14:23:50 INFO - 'TERM': 'linux', 14:23:50 INFO - 'TMOUT': '86400', 14:23:50 INFO - 'USER': 'cltbld', 14:23:50 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', 14:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:50 INFO - '_': '/tools/buildbot/bin/python'} 14:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:50 INFO - Downloading/unpacking jsonschema==2.5.1 14:23:50 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 14:23:50 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 14:23:50 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 14:23:50 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 14:23:50 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 14:23:50 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 14:23:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:23:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23:52 INFO - Downloading functools32-3.2.3-2.tar.gz 14:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:23:52 INFO - warning: no files found matching '*.txt' 14:23:52 INFO - no previously-included directories found matching 'build' 14:23:52 INFO - no previously-included directories found matching 'dist' 14:23:52 INFO - no previously-included directories found matching '.git*' 14:23:52 INFO - Installing collected packages: jsonschema, functools32 14:23:52 INFO - Running setup.py install for functools32 14:23:52 INFO - warning: no files found matching '*.txt' 14:23:52 INFO - no previously-included directories found matching 'build' 14:23:52 INFO - no previously-included directories found matching 'dist' 14:23:52 INFO - no previously-included directories found matching '.git*' 14:23:52 INFO - Successfully installed jsonschema functools32 14:23:52 INFO - Cleaning up... 14:23:52 INFO - Return code: 0 14:23:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:23:52 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')]} 14:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:52 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')]} 14:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:52 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 0x7f0286b3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2733350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c21c0>, '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 0x27c30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c3550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', '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 14:23:52 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 14:23:52 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 14:23:52 INFO - Using env: {'DISPLAY': ':0', 14:23:52 INFO - 'HOME': '/home/cltbld', 14:23:52 INFO - 'LANG': 'en_US.UTF-8', 14:23:52 INFO - 'LANGUAGE': 'en_US:en', 14:23:52 INFO - 'LOGNAME': 'cltbld', 14:23:52 INFO - 'MAIL': '/var/mail/cltbld', 14:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:52 INFO - 'MOZ_NO_REMOTE': '1', 14:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:52 INFO - 'NO_EM_RESTART': '1', 14:23:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:52 INFO - 'PWD': '/builds/slave/test', 14:23:52 INFO - 'SHELL': '/bin/bash', 14:23:52 INFO - 'SHLVL': '1', 14:23:52 INFO - 'TERM': 'linux', 14:23:52 INFO - 'TMOUT': '86400', 14:23:52 INFO - 'USER': 'cltbld', 14:23:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', 14:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:52 INFO - '_': '/tools/buildbot/bin/python'} 14:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:52 INFO - Downloading/unpacking blobuploader==1.2.4 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23:54 INFO - Downloading blobuploader-1.2.4.tar.gz 14:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:23:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:23:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:23:55 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 14:23:55 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 14:23:55 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 14:23:55 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 14:23:55 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 14:23:55 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 14:23:55 INFO - Downloading docopt-0.6.1.tar.gz 14:23:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:23:55 INFO - Installing collected packages: blobuploader, requests, docopt 14:23:55 INFO - Running setup.py install for blobuploader 14:23:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:23:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:23:55 INFO - Running setup.py install for requests 14:23:55 INFO - Running setup.py install for docopt 14:23:55 INFO - Successfully installed blobuploader requests docopt 14:23:55 INFO - Cleaning up... 14:23:56 INFO - Return code: 0 14:23:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:56 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')]} 14:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:56 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')]} 14:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:56 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 0x7f0286b3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2733350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c21c0>, '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 0x27c30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c3550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', '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 14:23:56 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 14:23:56 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 14:23:56 INFO - Using env: {'DISPLAY': ':0', 14:23:56 INFO - 'HOME': '/home/cltbld', 14:23:56 INFO - 'LANG': 'en_US.UTF-8', 14:23:56 INFO - 'LANGUAGE': 'en_US:en', 14:23:56 INFO - 'LOGNAME': 'cltbld', 14:23:56 INFO - 'MAIL': '/var/mail/cltbld', 14:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:56 INFO - 'MOZ_NO_REMOTE': '1', 14:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:56 INFO - 'NO_EM_RESTART': '1', 14:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:56 INFO - 'PWD': '/builds/slave/test', 14:23:56 INFO - 'SHELL': '/bin/bash', 14:23:56 INFO - 'SHLVL': '1', 14:23:56 INFO - 'TERM': 'linux', 14:23:56 INFO - 'TMOUT': '86400', 14:23:56 INFO - 'USER': 'cltbld', 14:23:56 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', 14:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:56 INFO - '_': '/tools/buildbot/bin/python'} 14:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:56 INFO - Running setup.py (path:/tmp/pip-opJQdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:56 INFO - Running setup.py (path:/tmp/pip-pSQmAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:56 INFO - Running setup.py (path:/tmp/pip-H32nl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:56 INFO - Running setup.py (path:/tmp/pip-YwAiyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:56 INFO - Running setup.py (path:/tmp/pip-hhcub9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:56 INFO - Running setup.py (path:/tmp/pip-dToMRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:56 INFO - Running setup.py (path:/tmp/pip-uAd7vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:56 INFO - Running setup.py (path:/tmp/pip-X0nNSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:56 INFO - Running setup.py (path:/tmp/pip-woFD8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:56 INFO - Running setup.py (path:/tmp/pip-eEnik9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:56 INFO - Running setup.py (path:/tmp/pip-z78vMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:57 INFO - Running setup.py (path:/tmp/pip-MgTUWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:57 INFO - Running setup.py (path:/tmp/pip-_VMYlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:57 INFO - Running setup.py (path:/tmp/pip-XevrNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:57 INFO - Running setup.py (path:/tmp/pip-CKnUxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:57 INFO - Running setup.py (path:/tmp/pip-YyCrnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:57 INFO - Running setup.py (path:/tmp/pip-OmieBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:23:57 INFO - Running setup.py install for manifestparser 14:23:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:23:57 INFO - Running setup.py install for mozcrash 14:23:57 INFO - Running setup.py install for mozdebug 14:23:57 INFO - Running setup.py install for mozdevice 14:23:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:23:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:23:57 INFO - Running setup.py install for mozfile 14:23:58 INFO - Running setup.py install for mozhttpd 14:23:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:23:58 INFO - Running setup.py install for mozinfo 14:23:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:23:58 INFO - Running setup.py install for mozInstall 14:23:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:23:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:23:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:23:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:23:58 INFO - Running setup.py install for mozleak 14:23:58 INFO - Running setup.py install for mozlog 14:23:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:23:58 INFO - Running setup.py install for moznetwork 14:23:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:23:58 INFO - Running setup.py install for mozprocess 14:23:58 INFO - Running setup.py install for mozprofile 14:23:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:23:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:23:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:23:58 INFO - Running setup.py install for mozrunner 14:23:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:23:58 INFO - Running setup.py install for mozscreenshot 14:23:59 INFO - Running setup.py install for moztest 14:23:59 INFO - Running setup.py install for mozversion 14:23:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:23:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:23:59 INFO - Cleaning up... 14:23:59 INFO - Return code: 0 14:23:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:59 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')]} 14:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:59 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')]} 14:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:59 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 0x7f0286b3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2733350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c21c0>, '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 0x27c30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c3550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', '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 14:23:59 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 14:23:59 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 14:23:59 INFO - Using env: {'DISPLAY': ':0', 14:23:59 INFO - 'HOME': '/home/cltbld', 14:23:59 INFO - 'LANG': 'en_US.UTF-8', 14:23:59 INFO - 'LANGUAGE': 'en_US:en', 14:23:59 INFO - 'LOGNAME': 'cltbld', 14:23:59 INFO - 'MAIL': '/var/mail/cltbld', 14:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:59 INFO - 'MOZ_NO_REMOTE': '1', 14:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:59 INFO - 'NO_EM_RESTART': '1', 14:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:59 INFO - 'PWD': '/builds/slave/test', 14:23:59 INFO - 'SHELL': '/bin/bash', 14:23:59 INFO - 'SHLVL': '1', 14:23:59 INFO - 'TERM': 'linux', 14:23:59 INFO - 'TMOUT': '86400', 14:23:59 INFO - 'USER': 'cltbld', 14:23:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', 14:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:59 INFO - '_': '/tools/buildbot/bin/python'} 14:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:59 INFO - Running setup.py (path:/tmp/pip-K0d8xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:59 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)) 14:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:59 INFO - Running setup.py (path:/tmp/pip-OXHGWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:59 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)) 14:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:59 INFO - Running setup.py (path:/tmp/pip-1LgiiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:59 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)) 14:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:59 INFO - Running setup.py (path:/tmp/pip-bk9wer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:59 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)) 14:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:59 INFO - Running setup.py (path:/tmp/pip-9ZCyw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:59 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)) 14:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:59 INFO - Running setup.py (path:/tmp/pip-SDW_i3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:59 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)) 14:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:59 INFO - Running setup.py (path:/tmp/pip-JNHzV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:59 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)) 14:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:00 INFO - Running setup.py (path:/tmp/pip-sCv0hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:00 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)) 14:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:00 INFO - Running setup.py (path:/tmp/pip-De82yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:00 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)) 14:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:00 INFO - Running setup.py (path:/tmp/pip-6KVzrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:00 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)) 14:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:00 INFO - Running setup.py (path:/tmp/pip-VYPdhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:00 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)) 14:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:00 INFO - Running setup.py (path:/tmp/pip-Rr45tH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:00 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)) 14:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:00 INFO - Running setup.py (path:/tmp/pip-aDa5IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:00 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)) 14:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:00 INFO - Running setup.py (path:/tmp/pip-5hyDqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:00 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)) 14:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:00 INFO - Running setup.py (path:/tmp/pip-SFzufb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:00 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)) 14:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:00 INFO - Running setup.py (path:/tmp/pip-8s8WOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:00 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)) 14:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:00 INFO - Running setup.py (path:/tmp/pip-HacQ0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:00 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)) 14:24:00 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)) 14:24:00 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)) 14:24:00 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)) 14:24:00 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)) 14:24:00 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)) 14:24:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:24:00 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 14:24:00 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 14:24:00 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 14:24:00 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 14:24:00 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 14:24:00 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 14:24:02 INFO - Downloading blessings-1.6.tar.gz 14:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:24:02 INFO - Installing collected packages: blessings 14:24:02 INFO - Running setup.py install for blessings 14:24:02 INFO - Successfully installed blessings 14:24:02 INFO - Cleaning up... 14:24:02 INFO - Return code: 0 14:24:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:24:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:03 INFO - Reading from file tmpfile_stdout 14:24:03 INFO - Current package versions: 14:24:03 INFO - argparse == 1.2.1 14:24:03 INFO - blessings == 1.6 14:24:03 INFO - blobuploader == 1.2.4 14:24:03 INFO - docopt == 0.6.1 14:24:03 INFO - functools32 == 3.2.3-2 14:24:03 INFO - jsonschema == 2.5.1 14:24:03 INFO - manifestparser == 1.1 14:24:03 INFO - mozInstall == 1.12 14:24:03 INFO - mozcrash == 0.17 14:24:03 INFO - mozdebug == 0.1 14:24:03 INFO - mozdevice == 0.48 14:24:03 INFO - mozfile == 1.2 14:24:03 INFO - mozhttpd == 0.7 14:24:03 INFO - mozinfo == 0.9 14:24:03 INFO - mozleak == 0.1 14:24:03 INFO - mozlog == 3.2 14:24:03 INFO - moznetwork == 0.27 14:24:03 INFO - mozprocess == 0.22 14:24:03 INFO - mozprofile == 0.28 14:24:03 INFO - mozrunner == 6.11 14:24:03 INFO - mozscreenshot == 0.1 14:24:03 INFO - mozsystemmonitor == 0.3 14:24:03 INFO - moztest == 0.7 14:24:03 INFO - mozversion == 1.4 14:24:03 INFO - psutil == 3.1.1 14:24:03 INFO - requests == 1.2.3 14:24:03 INFO - wsgiref == 0.1.2 14:24:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:03 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')]} 14:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:03 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')]} 14:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:03 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 0x7f0286b3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2733350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c21c0>, '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 0x27c30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c3550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', '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 14:24:03 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 14:24:03 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 14:24:03 INFO - Using env: {'DISPLAY': ':0', 14:24:03 INFO - 'HOME': '/home/cltbld', 14:24:03 INFO - 'LANG': 'en_US.UTF-8', 14:24:03 INFO - 'LANGUAGE': 'en_US:en', 14:24:03 INFO - 'LOGNAME': 'cltbld', 14:24:03 INFO - 'MAIL': '/var/mail/cltbld', 14:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:03 INFO - 'MOZ_NO_REMOTE': '1', 14:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:03 INFO - 'NO_EM_RESTART': '1', 14:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:03 INFO - 'PWD': '/builds/slave/test', 14:24:03 INFO - 'SHELL': '/bin/bash', 14:24:03 INFO - 'SHLVL': '1', 14:24:03 INFO - 'TERM': 'linux', 14:24:03 INFO - 'TMOUT': '86400', 14:24:03 INFO - 'USER': 'cltbld', 14:24:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', 14:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:03 INFO - '_': '/tools/buildbot/bin/python'} 14:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:03 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)) 14:24:03 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)) 14:24:03 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)) 14:24:03 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)) 14:24:03 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)) 14:24:03 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)) 14:24:03 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)) 14:24:03 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)) 14:24:03 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)) 14:24:03 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)) 14:24:03 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)) 14:24:03 INFO - Cleaning up... 14:24:03 INFO - Return code: 0 14:24:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:24:03 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')]} 14:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:03 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')]} 14:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:03 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 0x7f0286b3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2733350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c21c0>, '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 0x27c30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c3550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', '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 14:24:03 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 14:24:03 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 14:24:03 INFO - Using env: {'DISPLAY': ':0', 14:24:03 INFO - 'HOME': '/home/cltbld', 14:24:03 INFO - 'LANG': 'en_US.UTF-8', 14:24:03 INFO - 'LANGUAGE': 'en_US:en', 14:24:03 INFO - 'LOGNAME': 'cltbld', 14:24:03 INFO - 'MAIL': '/var/mail/cltbld', 14:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:03 INFO - 'MOZ_NO_REMOTE': '1', 14:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:03 INFO - 'NO_EM_RESTART': '1', 14:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:03 INFO - 'PWD': '/builds/slave/test', 14:24:03 INFO - 'SHELL': '/bin/bash', 14:24:03 INFO - 'SHLVL': '1', 14:24:03 INFO - 'TERM': 'linux', 14:24:03 INFO - 'TMOUT': '86400', 14:24:03 INFO - 'USER': 'cltbld', 14:24:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', 14:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:03 INFO - '_': '/tools/buildbot/bin/python'} 14:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:24:03 INFO - Cleaning up... 14:24:03 INFO - Return code: 0 14:24:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:24:03 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')]} 14:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:03 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')]} 14:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:03 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 0x7f0286b3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2733350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c21c0>, '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 0x27c30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c3550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', '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 14:24:03 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 14:24:03 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 14:24:03 INFO - Using env: {'DISPLAY': ':0', 14:24:03 INFO - 'HOME': '/home/cltbld', 14:24:03 INFO - 'LANG': 'en_US.UTF-8', 14:24:03 INFO - 'LANGUAGE': 'en_US:en', 14:24:03 INFO - 'LOGNAME': 'cltbld', 14:24:03 INFO - 'MAIL': '/var/mail/cltbld', 14:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:03 INFO - 'MOZ_NO_REMOTE': '1', 14:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:03 INFO - 'NO_EM_RESTART': '1', 14:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:03 INFO - 'PWD': '/builds/slave/test', 14:24:03 INFO - 'SHELL': '/bin/bash', 14:24:03 INFO - 'SHLVL': '1', 14:24:03 INFO - 'TERM': 'linux', 14:24:03 INFO - 'TMOUT': '86400', 14:24:03 INFO - 'USER': 'cltbld', 14:24:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', 14:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:03 INFO - '_': '/tools/buildbot/bin/python'} 14:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:03 INFO - Downloading/unpacking flake8 14:24:03 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 14:24:03 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 14:24:03 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 14:24:03 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 14:24:03 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 14:24:03 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 14:24:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:24:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:24:05 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 14:24:05 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 14:24:05 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 14:24:05 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 14:24:05 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 14:24:05 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 14:24:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:24:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:24:05 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 14:24:05 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 14:24:05 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 14:24:05 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 14:24:05 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 14:24:05 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 14:24:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:24:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:24:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:24:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:24:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:24:06 INFO - no previously-included directories found matching 'docs/_build' 14:24:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:24:06 INFO - Running setup.py install for pep8 14:24:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:24:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:24:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:24:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:24:06 INFO - no previously-included directories found matching 'docs/_build' 14:24:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:24:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:24:06 INFO - Cleaning up... 14:24:06 INFO - Return code: 0 14:24:06 INFO - Running post-action listener: _resource_record_post_action 14:24:06 INFO - Running post-action listener: _start_resource_monitoring 14:24:06 INFO - Starting resource monitoring. 14:24:06 INFO - ##### 14:24:06 INFO - ##### Finished create-virtualenv step (success) 14:24:06 INFO - ##### 14:24:06 INFO - ##### 14:24:06 INFO - ##### Running install step. 14:24:06 INFO - ##### 14:24:06 INFO - Running pre-action listener: _resource_record_pre_action 14:24:06 INFO - Running main action method: install 14:24:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:24:06 INFO - Reading from file tmpfile_stdout 14:24:06 INFO - Detecting whether we're running mozinstall >=1.0... 14:24:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:24:06 INFO - Reading from file tmpfile_stdout 14:24:06 INFO - Output received: 14:24:06 INFO - Usage: mozinstall [options] installer 14:24:06 INFO - Options: 14:24:06 INFO - -h, --help show this help message and exit 14:24:06 INFO - -d DEST, --destination=DEST 14:24:06 INFO - Directory to install application into. [default: 14:24:06 INFO - "/builds/slave/test"] 14:24:06 INFO - --app=APP Application being installed. [default: firefox] 14:24:06 INFO - mkdir: /builds/slave/test/build/application 14:24:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:24:23 INFO - Reading from file tmpfile_stdout 14:24:23 INFO - Output received: 14:24:23 INFO - /builds/slave/test/build/application/firefox/firefox 14:24:23 INFO - Running post-action listener: _resource_record_post_action 14:24:23 INFO - ##### 14:24:23 INFO - ##### Finished install step (success) 14:24:23 INFO - ##### 14:24:23 INFO - ##### 14:24:23 INFO - ##### Running run-tests step. 14:24:23 INFO - ##### 14:24:23 INFO - Running pre-action listener: _resource_record_pre_action 14:24:23 INFO - Running main action method: run_tests 14:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:24:23 INFO - Python 2.7.3 14:24:23 INFO - Return code: 0 14:24:23 INFO - grabbing minidump binary from tooltool 14:24:23 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')]} 14:24:23 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 0x27c21c0>, '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 0x27c30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c3550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:24:23 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 14:24:23 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 14:24:23 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 14:24:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:24:23 INFO - Return code: 0 14:24:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:24:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:24:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:24:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:24:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:24:24 INFO - Return code: 0 14:24:24 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:24:24 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:24:24 INFO - Using env: {'DISPLAY': ':0', 14:24:24 INFO - 'HOME': '/home/cltbld', 14:24:24 INFO - 'LANG': 'en_US.UTF-8', 14:24:24 INFO - 'LANGUAGE': 'en_US:en', 14:24:24 INFO - 'LOGNAME': 'cltbld', 14:24:24 INFO - 'MAIL': '/var/mail/cltbld', 14:24:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:24:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:24 INFO - 'MOZ_NO_REMOTE': '1', 14:24:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:24:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:24 INFO - 'NO_EM_RESTART': '1', 14:24:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:24 INFO - 'PWD': '/builds/slave/test', 14:24:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:24:24 INFO - 'SHELL': '/bin/bash', 14:24:24 INFO - 'SHLVL': '1', 14:24:24 INFO - 'TERM': 'linux', 14:24:24 INFO - 'TMOUT': '86400', 14:24:24 INFO - 'USER': 'cltbld', 14:24:24 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993', 14:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:24 INFO - '_': '/tools/buildbot/bin/python'} 14:24:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:24:24 INFO - mozversion application_buildid: 20160605113024 14:24:24 INFO - mozversion application_changeset: f42a04d822baa22a4741c4fff1aab2054857e398 14:24:24 INFO - mozversion application_display_name: Nightly 14:24:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:24:24 INFO - mozversion application_name: Firefox 14:24:24 INFO - mozversion application_remotingname: firefox 14:24:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:24:24 INFO - mozversion application_vendor: Mozilla 14:24:24 INFO - mozversion application_version: 49.0a1 14:24:24 INFO - mozversion platform_buildid: 20160605113024 14:24:24 INFO - mozversion platform_changeset: f42a04d822baa22a4741c4fff1aab2054857e398 14:24:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:24:24 INFO - mozversion platform_version: 49.0a1 14:24:24 INFO - using testdate: 1465161864 14:24:24 INFO - actual date: 1465161864 14:24:24 INFO - starting webserver on 'localhost:44162' 14:24:24 INFO - SUITE-START | Running 2 tests 14:24:24 INFO - TEST-START | dromaeo_css 14:24:24 INFO - operating with platform_type : linux_ 14:24:24 INFO - Initialising browser for dromaeo_css test... 14:24:24 INFO - TEST-INFO | started process 9015 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvVWySQ/profile http://localhost:44162/getInfo.html) 14:24:28 INFO - PROCESS | 9015 | __metrics Screen width/height:1600/1200 14:24:28 INFO - PROCESS | 9015 | colorDepth:24 14:24:28 INFO - PROCESS | 9015 | Browser inner width/height: 1024/697 14:24:28 INFO - PROCESS | 9015 | __metrics 14:24:30 ERROR - PROCESS | 9015 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:24:31 INFO - TEST-INFO | 9015: exit 0 14:24:31 INFO - Browser initialized. 14:24:31 INFO - Running cycle 1/1 for dromaeo_css test... 14:24:31 INFO - TEST-INFO | started process 9096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvVWySQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:24:42 INFO - PROCESS | 9096 | RSS: Main: 155910144 14:24:42 INFO - PROCESS | 9096 | 14:25:34 INFO - PROCESS | 9096 | 1465161934676 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] 14:27:42 INFO - PROCESS | 9096 | Cycle 1(1): loaded http://localhost:44162/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44162/tests/dromaeo/cssquery-ext.html) 14:27:43 INFO - PROCESS | 9096 | RSS: Main: 254480384 14:27:43 INFO - PROCESS | 9096 | 14:30:45 INFO - PROCESS | 9096 | Cycle 1(1): loaded http://localhost:44162/tests/dromaeo/cssquery-ext.html (next: http://localhost:44162/tests/dromaeo/cssquery-jquery.html) 14:30:46 INFO - PROCESS | 9096 | RSS: Main: 248377344 14:30:46 INFO - PROCESS | 9096 | 14:33:48 INFO - PROCESS | 9096 | Cycle 1(1): loaded http://localhost:44162/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44162/tests/dromaeo/cssquery-mootools.html) 14:33:48 INFO - PROCESS | 9096 | RSS: Main: 251760640 14:33:48 INFO - PROCESS | 9096 | 14:36:50 INFO - PROCESS | 9096 | Cycle 1(1): loaded http://localhost:44162/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44162/tests/dromaeo/cssquery-prototype.html) 14:36:51 INFO - PROCESS | 9096 | RSS: Main: 243302400 14:36:51 INFO - PROCESS | 9096 | 14:39:54 INFO - PROCESS | 9096 | Cycle 1(1): loaded http://localhost:44162/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44162/tests/dromaeo/cssquery-yui.html) 14:39:54 INFO - PROCESS | 9096 | RSS: Main: 216399872 14:39:54 INFO - PROCESS | 9096 | 14:42:57 INFO - PROCESS | 9096 | Cycle 1(1): loaded http://localhost:44162/tests/dromaeo/cssquery-yui.html (next: http://localhost:44162/tests/dromaeo/cssquery-dojo.html) 14:42:57 INFO - PROCESS | 9096 | RSS: Main: 275001344 14:42:57 INFO - PROCESS | 9096 | 14:42:57 INFO - PROCESS | 9096 | __start_tp_report 14:42:57 INFO - PROCESS | 9096 | _x_x_mozilla_page_load 14:42:57 INFO - PROCESS | 9096 | _x_x_mozilla_page_load_details 14:42:57 INFO - PROCESS | 9096 | |i|pagename|runs| 14:42:57 INFO - PROCESS | 9096 | |0;dojo.html;3103.503439449688;3105.5186446100856;3111.844407779612;3143.669914658962;3169.857356418961;5248.632595718292;5320.920186197201;5357.517823395893;5410.702411367373;5411.404745477994;5299.125644268691;5365.302510673617;5409.513143817056;5429.348478182614;5504.284443022411;4748.5251474852585;4833.178359678863;4852.951470485303;4861.124997500448;4967.279744437054;4909.239067944474;5010.924836127461;5038.244263360489;5045.4197767256865;5093.617978651598;4761.476237613842;4809.831655892027;4812.37439132914;4936.136176169156;4954;4875.53682400175;4877.463479017305;4882.926756098661;4892.559669629751;4895.485973972717;4826.541478559531;4839.758012099381;4840.15297322967;4840.273958906157;4866.172750632401;5220.556252718524;5260.736963151827;5290.788368465257;5302.681839089667;5320.840374788762;5748.655080695172;5794.565407594405;5795.797147099874;5837.678927658977;5843.444872737083;5842.678652674102;5864.853378665525;5870.178175055496;5873;5877.529797616223;5092;5424.484673956007;5429.837104886859;5474.288342515448;5479.0411677957;6008.399160083956;6024.427679370453;6027.57806953509;6029.8191054268445;6042.939570604238;5785.161151633074;5793.449622285961;5801.071828507418;5802.187693722883;5802.535797136219;5578.30271216098;5718.428157184248;5797.420257974169;5805.767769289266;5881.882362352729;5791.5656325775735;5801.158831969341;5804.709764511757;5806.854828629318;5808.070708686674;5805.10020946754;5807.390224026501;5816.82549523515;5819.6508209507565;5819.709014549256;4261.936070958938;4273.700840941105;4276.8289268429535;4337.240982827992;4338.652907767371;3854.402567602026;3912.276228897606;3929.7445666031617;3930.744501607386;3932.8820135395986;5399.919001214985;5406.297181366397;5406.756695948692;5411.945880541223;5476.890462190734;5836.795712150054;5842.532597392198;5846.356900740915;5878.441548052928;5899;5536.612437129443;5546.584006199551;5549.19536667181;5551.916721249185;5553.361363443175;4900.632452566072;4955.752212389366;5002.974985125124;5005.049040682332;5028.673136246132;5984.7606095756555;5990.101484777319;5994.700264986734;6002.879942401128;6005.189299444606;5787.797427090031;5802.390748971382;5826.883462330815;5827.737751801264;5829.358770535323;5853.473187413153;5942.435468630473;5983.072623743153;6010.909836352545;6042.093685947143;5726.885462290814;5726.9713651431475;5729.770809167753;5733.541316694738;5739.827805165852;5602.383737788921;5816.21481100063;5829.76680932758;5830.53355731532;5832.183494310885;5613.045782217115;5653.858653533694;5691;5712.37163911961;5733.168690539765;5677.602567820213;5683.8010669626365;5686.630369026166;5687.77248910039;5688.715564221855;5355.22349259363;5533.2253484513;5552.333719953632;5603.859903502445;5611.354694210218;5671.602987790815;5790.044642634087;5793;5795.710214489174;5797.2173756542325;5596.636218645775;5601.439856014366;5607.859803504945;5608.635438696635;5609.691466969356 14:42:57 INFO - PROCESS | 9096 | |1;ext.html;595.6694034810681;620.5159975219325;621.2079598511893;631.7409861956598;656.4354654996704;34047.489287660705;36888.44667329992;36923.99999999996;36940.44589331159;44868.32697509532;43437;47945.760271198684;48023.51976480234;48119.51880481194;48248.51751482484;8724.38929274951;8898.644054237822;8908.287337013056;8926.509042002688;8931.464112153259;8690.522021288827;8829.028806831244;8837.95581022094;8843.469391836477;8845.115488451136;8853.24747396472;8895;8896.911030889672;8900.109989001081;8903.154200350957;8829.381943263974;8853.11468853116;8871.512066836322;8880.289576833839;8882.11178882113;8740;8741.344399170088;8743.519106449143;8759.956200218958;8825.338099642553;43228;43533.12933741308;43728.781356093335;43741.56258437406;43751.96852361987;3425.400554902907;3623.873164439232;4001.639852413297;4161.604647558507;4248.065425606362;32576.837115814506;33549.32901341984;33607.49588756171;33619.32761344784;33760.49359259613;4303.612674859278;4334.501532323791;4380.67144964129;4382.17039684031;4413.183561041185;339211;341620;342255;342581;342596;60546.394536054075;60973;61209.69395153085;61291.693541532004;61329.080063799076;62821;63080.47678092825;63359;63449.68275158595;63493.36506634874;15522.844771552365;15549.378024879104;15736.134512601917;15760.76358854618;15766.211689415484;12103.515859365527;12222;12249.632511024683;12256.754864902652;12272.938635306766;18263.360782372554;18455.354062607745;18623.44129676112;18639.81360186408;18693.439196824118;5671.6597004179885;5775.249217601685;5836.299644042742;5888.322842873039;6066.666333351708;958.5399008475971;1032.9431881246453;1071.223363061774;1120.8542889424486;1192.0761409907218;33375.49936750951;33547.17244264711;33890;33959.83020084884;34161;977.61384253221;1077.7790552936629;1146.6789298996293;1147.002108165901;1170.8185231289165;17614;17806;17810.19854106568;17875.462245019567;17910.89404963615;558451;562404;567221;567838;569414;60234;60479.09281360783;60626.39373606208;60640.09039864405;60715.69642151849;1259.200407741091;1364.3860262881742;1387.2924808347816;1398.4476131927831;1413.6889884225454;30591;34530.65469345274;34746.47880281747;34787.826060869535;34946.051165184355;51171.48828511667;51498.48501514937;51912.74043629758;51978.48021519736;51984.22023669572;397136;406959;407237;407672;408208;36528.81735591305;37341.6265837349;37930.775884049064;42685.57314426816;47391.52608473871;44428;48858.511414886816;50040.749796250784;50322.49677503178;50929.745351273006;40564.59435405726;41966;42248.36627450652;43127.784361078;43896;41368.1726365465;41398.58601414068;41797.79101104596;42310;42967;40914;42411.363829543196;42680.5731942689;43314;43521.34717979296;33949.49075763915;36796.26407471889;37310;37657.2468550622;37673.246535068596;28231.57652635253;28273.37950894979;28376;28542;28605.28486787847 14:42:57 INFO - PROCESS | 9096 | |2;jquery.html;382.45593442494663;383.6278809554731;388.5861557441323;401.6726368010072;413.0417431558783;14234.359453824576;16540.83459165408;18255.36106236282;19887.801121988774;19910.90044549777;18079.548011299692;18972.214515042182;19210.711839322386;19768.30810921618;19831.900840495815;5537.280153580029;5539.695316757577;5633.915491267634;5634.211210430543;5637.154426835967;4091.079507110906;5473.233747275384;5616.719164041802;5630.40880707526;6088.573799834014;6357.173567436227;6370.044493326015;6375.904361434559;6384.07430922516;6387.233531976146;6216.347283535254;6292.433680968712;6348.682565871711;6371.331010243927;6374.713137908759;5560.888782224333;5577;5577.609567330289;5580.748866301026;5581.107022876361;22320.330390088322;22614;23224;23329.3001209964;23554;2287.7712228777154;2584.6769153855766;2634.5671142276606;3046.025271912989;3057.9541306880415;13693.794593081111;13900.791488127687;14344.42622295107;14478.348474318682;14785.556433307018;1954.8436125109956;1964.3321270767865;1974.6544354737864;1982.0684278389133;2034.4812072921459;77371;77789.99999999943;78400;78517;79389;10296.124829389437;10413.9479302603;10770.084542813793;11107.222494425312;11177.161712871404;12901.483940642456;13471.259080750457;14445.711085778436;14472.204028778518;14913.105213687213;7780.961095194488;7926;7993.241486872878;8170.754877353689;8202.794930126794;7638.236176382317;7710.537367757953;7779.45543811939;7863.33161681252;7896.052473703192;6632.0383544385795;6682.431993280528;6690.612716647792;6767.72929082841;6774.220964589135;1862.5064357945155;1869.4298239037225;1873.8875667459995;1881.130871680366;1941.1361943934814;908.246155690775;988.48104745008;992.6128809764198;993.6919554937992;1087.1737479515625;19231;19594.216231350587;19667.311644092388;19703.310384136486;19913;1001.329109496639;1010.4745532323298;1028.8713910761155;1054.6256079091966;1079.4926384599225;10937.4531273436;11374.772504549863;11391.886081139248;11444.141689373164;11447.370394628375;353661;356605;356868;488949;495816;98921.50539247258;101975;102295.48852255692;103735.48132259291;105973;1000.884898236712;1003.6437064842022;1021.1626466297713;1023.9232057595561;1029.0584115534202;17462;18033.92609849884;18331.908340458212;18346.816531835044;18723.344682936033;42622;43171.35242971295;43733.12533749371;44391;44918;58183;60352;62446;63003;63017.68491157515;8595.742127736177;8656.437331573428;8689.826203476021;8881.866771998297;8900.910990890008;10131;13137.408816603467;13188.802167967297;13558.525451609146;14000.719985600435;11513.942430287794;11917.582884598998;12137.089718271342;12203.145779795685;12275.93862030684;11705.180637355645;11949.701257468632;12063.638090857288;12103.092268080105;12360.567380141652;7578.924210757822;9288.62845486173;12202.81695774582;12500.937495312466;12665.240085594894;8496.745097647081;8540.658373664985;8551.786205344915;8586.78533036679;8614.44006139624;9146.542672866462;11816.82274765862;12222.694432639255;12276.754464910473;12377.257364558156 14:42:57 INFO - PROCESS | 9096 | |3;mootools.html;1325.1717676452217;1470.037125682678;1511.297246780247;1645.8518733314;1809.294375193674;8379.958100209498;8808.42745221561;8849.469031858085;9124.954375228115;9138.771530711736;8865.734027979155;8982.281417486602;9033.277337812975;9062.864057039133;9063.864042039375;2030.2386605023116;2287.874166920819;2357.7288611809604;2383.4875501767115;2384.8092152627746;2318.5594737;2391.222852572912;2393.066703985447;2393.5093305872256;2394.3774618599205;2375.2043065573052;2381.940451488718;2403.351095204294;2403.5433267679086;2404.5791986402396;2006.3679940818595;2271.5797577448225;2357.65813956977;2362.5393048355577;2367.573836709392;2059.855810093294;2085.3431169181813;2091.8117369436823;2096.329174664108;2111.7782632823487;8850.690225842065;8900.732978010605;8907.643694252221;8912.019677835433;8912.376133670581;5258.842234732964;5413.052715774763;5414.35027796667;5416.268803711488;5420.322459692538;3339.1151344893624;3345.3643807676463;3409.2840503494294;3416.8462419190946;3556.8043757593323;1020.9795804083951;1059.2479339668844;1061.6231237910508;1077.6389909380366;1083.3337497439097;11909.583164589285;12086.33525156116;12106.394680265952;12111.576094836639;12113.45489452968;4631.976840115778;4635.119327327797;4772.570468657837;4774;4783.689060211075;10351.534180961875;10379.481025948673;10379.896201038044;10381.065704086668;10395.636152734769;5217.8173763918085;5234.2933703949475;5272.868178295574;5276.208568714646;5281.234221038005;4122.361034039729;4812.133815913099;4963.602911767122;4968.925466118011;5026.748662566857;4026.898307329389;4044.4337792709043;4068.4100805383055;4081.775502347399;4094.3653733670735;1268.1883594499527;1276.074845736852;1283;1286.9356532173354;1292.1213574769247;902.4089221559889;1018.592562974816;1021.4331046269392;1027.1782573940818;1033.8087453820917;5964.85087872798;6060.606060606046;6128.571000029955;6144.354842741537;6144.662043587646;977.1059480575194;992.7815880506278;994.5524513968743;1018.4449475036123;1038.89611038897;4059.512858456945;4147.129102888427;4187.45563076798;4229.809658565372;4246.745195288293;11119.166062545342;11480.483378247998;11502;11503.137264705181;11517.596884109016;11191.944040279746;11269.9293567111;11349.262297950607;11359.261647992855;11365.09079273656;8012.79968000793;8333.125021872738;8380.832383352299;8477.533735644598;8485.0666426693;5870.618409803349;5914.2311499504785;5949.494292985145;5950.31571369298;5955.3746856581165;10157.492125393848;10435.843462348223;10553.841692374466;10556.049955504042;10572.41851698164;10394.116500097274;10426.895731042592;10577.259591828806;10639.361638301727;10769.192310576582;6400.679966001774;7213;7438.70245190208;7455.105387353552;7597.468177227541;8723.563821808757;8745.693900713444;8777.868331974898;8819.514926679094;8819.559022049;7634.618269086634;7811.218878112143;7833.37333013369;7981.880271796043;7984.92015079865;7489.887651685338;7750.341220996278;7791.571463569559;7972;7973.242541958504;7045.225025247116;7181.317774811385;7282;7284.125904891447;7285.562866228043;5070.518300761421;5092.287079808756;5179.22311653255;5232.502912223333;5250.448702886142;5009.799608015638;5009.824656137018;5102.1326374515675;5392.08334583114;5431.131019036935 14:42:57 INFO - PROCESS | 9096 | |4;prototype.html;321.455133548635;329.06545411032664;333.6930024377572;335.485030478216;336.50869730193915;5254.238135470355;5266.5786737061035;5272.551833094191;5287.360918115382;5383.353997520303;5236.973815130919;5255.395629502608;5264.710440925747;5272.209168624709;5281.155015197569;4138.586141385867;4148.419221309019;4159.9376009359885;4168.395582640515;4171.207470580595;3921.4313924481075;3945.9210815783667;4071.206114807599;4098.631123198911;4122.835086596532;4029.81865816039;4038.3336749436307;4057.944934317084;4069.1454794493043;4075.6331930126285;3905.8632947846972;4064.5732198119217;4092.1815636872598;4113.6297733203855;4123.835046598132;3550.414181660023;3599.8560057597665;3603.387424137903;3627.383344831385;3641.4173732202985;5037.647364684473;5038.39539255288;5051.2423136529815;5058.671186372911;5100.7959681613065;4605.723656580582;4620.2607582786595;4628.685657171414;4665.976670116627;4694.29585562165;5425.37608175057;5447.12845944647;5463.9180412293845;5469.808556700536;5486.31421072366;3947.624975627311;3987.4018897165365;3994.660453861425;4009.7794621295816;4015.437838702584;5500.047483143507;5754.338251101093;5763.9135412968835;5771.153230966092;5772.624779389368;4051.736637118578;4085.9591404085577;4106.096658735073;4116.156187981516;4119.546849846514;4104.486939132608;4123.340265557496;4125.154343359664;4137.77242251679;4153.397757325171;4672.672912896132;4676.134915040729;4684.929726054112;4697.342372067913;4712.151812673683;5247.2653828464045;5434.619576629598;5454.645448045864;5470.206820011076;5520.696361700145;1392.8537503562184;1406.521782593923;1418.4113592858848;1433.218895701845;1437.7268319019563;890.8708237305555;920.0753242990752;931.366670663955;939.1594522901964;943.3632298198826;4776;5121.103806833789;5178.326817513699;5341.545968592635;5450.182472629137;5716.28546431696;5721.199032135504;5727.169560413717;5728.971355143198;5742.827715168552;5212.4266330703595;5352.474544754727;5424.891502169935;5466;5471.644343117685;2987.3129180288656;2998.4602771500904;3000.349807605808;3014.6533148687745;3019.6980301970066;5792.739326730307;5821.301443826683;5828.504577110993;5833.329167145747;5963.880722385528;5649.350324712628;5709.00277354384;5782.392848750905;5814.825555233349;5824.242848429762;5872.706364681749;5878.235829342244;5883.176355310346;5902.734376953047;5911.290645122613;5411.945880541144;5570.303712035996;5672.837068401051;5691.8861622768145;5699.287589051369;5558.221848941233;5584.804531841366;5591.8881622368135;5595.832125036255;5599.272094627835;5740.885182296414;5749.310082789924;5814.122009605272;5819.388964158702;5888.587798854039;3746.5878753337656;3977.582353852804;4111.8560850370095;4117.22959127578;4145.7719825409895;5587.106063029895;5600.983645887396;5604.943950560605;5607.43925607436;5644.407337229532;5516.089845175501;5542.501174894279;5547.4175211603815;5551.583631227593;5562.137868630369;5388.703621300866;5452.482014208644;5464.23500709893;5491.725413729378;5552.917655879045;5326.493983071602;5335.2263921730355;5336.332958380202;5389.9759045781175;5398.3791863934575;5252.133397989289;5388.811391601275;5426.70153141581;5517.227588137584;5574.247476590608;5400.62195646301;5421.105517589711;5423.674579525241;5439.80324328647;5443.292371991616 14:42:57 INFO - PROCESS | 9096 | |5;yui.html;710.9360157585817;734.434485446206;748.3676293531967;816.783552358625;853.0914575976584;14602;14697.70604587909;14791.186484743348;14808.925955370236;14829.703405931876;12628.558000469986;12635.936820315908;12745.107842451009;12763;13405.865941340584;791.5527726834334;811.0389188811278;818.7257268814955;819.0253598218102;820.3027426687298;683.402023229674;787.2363807107125;807.4025221336199;809.3363441977551;814.4583851738587;863.8790569320269;864.3387808326635;864.3430992445755;868.9348298877578;869.6173683579236;707.4587940225731;858.3390789092396;864.0754392799707;865.2126564825978;865.9997702653445;603.5171862510018;617.6510271696523;618.2056057965493;621.1521273461692;624.0670198053894;13323.66690832737;13336.466541338335;13345.532906348231;13350.19898806065;13363.732725345535;14011.929940350234;14598.124112553282;14658.70682586353;14730.484433044792;15130.54608361751;12850;12861;13119;13194;13646.590602281849;4367.578934838458;4526.207913615104;4551.954480455186;4564.064366804797;4769.928451073237;72588.63705681438;73852.26147738508;73929.63035184843;74015.62992185005;74355;11618.909322379392;11689.240199387013;11715.589954351728;11854.525818967317;12065.034797216202;21828.345149645535;21865.234716784835;21926;21942.89028554847;21987.780122198572;7954.960225198837;8085.43401961857;8111.95944020288;8238.299744521662;8408.453450525696;4760.928586071212;4774.474807771142;4783.354247176587;4809.879753006203;4899.608031357483;3448.8620455181513;3587.443946188345;3589.820508974593;3590;3590.479380489867;617.7251123250111;635.0632816595577;638.8370965403885;640.6828619833119;650.9804705858832;575.807104619957;628.355935166449;707.4199156691463;712.7826013065961;731.3637135691876;9696.224302055818;9847.901520984842;9963;10110.24173187014;10150.238732095122;588.9852753681192;624.8406656302705;644.8387903024244;645.4961077474361;659.4183770538384;4643.210654188796;5211.114110601131;5222.712750798667;5300.893982120413;5460.290162278879;82848.44333561712;119960.40019799845;120819;122608.38695806642;125249.37375313065;71707;85768.57115714507;104219;105463;105825.47087264515;88123.55938220269;90935;91649.54175229081;93697.531512342;95932.52033739787;10461.529231184768;10507.383945164891;10550.366977981346;10698.251122421356;10715.624953126604;52133.21800173076;52735;52924.47075529349;54056.459435405144;54504.454955451525;71817;72456.27543724496;78495.60752196431;80310.36275646959;80343;13412.262325571797;13540.661483462993;13559.661008474472;13612.93193534026;13858.099223550436;14125.858741412865;14295.785563216352;14512;14586.343614537584;14601;14411;14436.474442141112;14844.7773283403;15054.172020538537;15326.233688315762;13602.727945441233;13639.727205455636;13640.79538806899;13667.179969201481;13674.949837938017;13157.079004469595;13599.076138897597;13671.79492307636;13674.453021879412;14050.367733452224;11749.177557571229;11911.3448760319;11937.28376297425;12062.939685301517;12377.938110309391;11784.941075294568;11821.468033938665;12039.939800300943;12139.75720485603;12192.146549741788 14:42:57 INFO - PROCESS | 9096 | __end_tp_report 14:42:57 INFO - PROCESS | 9096 | __start_cc_report 14:42:57 INFO - PROCESS | 9096 | _x_x_mozilla_cycle_collect,863 14:42:57 INFO - PROCESS | 9096 | __end_cc_report 14:42:57 INFO - PROCESS | 9096 | __startTimestamp1465162977875__endTimestamp 14:42:57 INFO - PROCESS | 9096 | 14:42:57 INFO - PROCESS | 9096 | ------- Summary: start ------- 14:42:57 INFO - PROCESS | 9096 | Number of tests: 6 14:42:57 INFO - PROCESS | 9096 | 14:42:57 INFO - PROCESS | 9096 | [#0] dojo.html Cycles:165 Average:5376.84 Median:5603.86 stddev:635.94 (11.3%) stddev-sans-first:612.37 14:42:57 INFO - PROCESS | 9096 | Values: 3103.5 3105.5 3111.8 3143.7 3169.9 5248.6 5320.9 5357.5 5410.7 5411.4 5299.1 5365.3 5409.5 5429.3 5504.3 4748.5 4833.2 4853.0 4861.1 4967.3 4909.2 5010.9 5038.2 5045.4 5093.6 4761.5 4809.8 4812.4 4936.1 4954.0 4875.5 4877.5 4882.9 4892.6 4895.5 4826.5 4839.8 4840.2 4840.3 4866.2 5220.6 5260.7 5290.8 5302.7 5320.8 5748.7 5794.6 5795.8 5837.7 5843.4 5842.7 5864.9 5870.2 5873.0 5877.5 5092.0 5424.5 5429.8 5474.3 5479.0 6008.4 6024.4 6027.6 6029.8 6042.9 5785.2 5793.4 5801.1 5802.2 5802.5 5578.3 5718.4 5797.4 5805.8 5881.9 5791.6 5801.2 5804.7 5806.9 5808.1 5805.1 5807.4 5816.8 5819.7 5819.7 4261.9 4273.7 4276.8 4337.2 4338.7 3854.4 3912.3 3929.7 3930.7 3932.9 5399.9 5406.3 5406.8 5411.9 5476.9 5836.8 5842.5 5846.4 5878.4 5899.0 5536.6 5546.6 5549.2 5551.9 5553.4 4900.6 4955.8 5003.0 5005.0 5028.7 5984.8 5990.1 5994.7 6002.9 6005.2 5787.8 5802.4 5826.9 5827.7 5829.4 5853.5 5942.4 5983.1 6010.9 6042.1 5726.9 5727.0 5729.8 5733.5 5739.8 5602.4 5816.2 5829.8 5830.5 5832.2 5613.0 5653.9 5691.0 5712.4 5733.2 5677.6 5683.8 5686.6 5687.8 5688.7 5355.2 5533.2 5552.3 5603.9 5611.4 5671.6 5790.0 5793.0 5795.7 5797.2 5596.6 5601.4 5607.9 5608.6 5609.7 14:42:57 INFO - PROCESS | 9096 | 14:42:57 INFO - PROCESS | 9096 | [#1] ext.html Cycles:180 Average:60736.28 Median:42826.29 stddev:118627.36 (277.0%) stddev-sans-first:118874.20 14:42:57 INFO - PROCESS | 9096 | Values: 595.7 620.5 621.2 631.7 656.4 34047.5 36888.4 36924.0 36940.4 44868.3 43437.0 47945.8 48023.5 48119.5 48248.5 8724.4 8898.6 8908.3 8926.5 8931.5 8690.5 8829.0 8838.0 8843.5 8845.1 8853.2 8895.0 8896.9 8900.1 8903.2 8829.4 8853.1 8871.5 8880.3 8882.1 8740.0 8741.3 8743.5 8760.0 8825.3 43228.0 43533.1 43728.8 43741.6 43752.0 3425.4 3623.9 4001.6 4161.6 4248.1 32576.8 33549.3 33607.5 33619.3 33760.5 4303.6 4334.5 4380.7 4382.2 4413.2 339211.0 341620.0 342255.0 342581.0 342596.0 60546.4 60973.0 61209.7 61291.7 61329.1 62821.0 63080.5 63359.0 63449.7 63493.4 15522.8 15549.4 15736.1 15760.8 15766.2 12103.5 12222.0 12249.6 12256.8 12272.9 18263.4 18455.4 18623.4 18639.8 18693.4 5671.7 5775.2 5836.3 5888.3 6066.7 958.5 1032.9 1071.2 1120.9 1192.1 33375.5 33547.2 33890.0 33959.8 34161.0 977.6 1077.8 1146.7 1147.0 1170.8 17614.0 17806.0 17810.2 17875.5 17910.9 558451.0 562404.0 567221.0 567838.0 569414.0 60234.0 60479.1 60626.4 60640.1 60715.7 1259.2 1364.4 1387.3 1398.4 1413.7 30591.0 34530.7 34746.5 34787.8 34946.1 51171.5 51498.5 51912.7 51978.5 51984.2 397136.0 406959.0 407237.0 407672.0 408208.0 36528.8 37341.6 37930.8 42685.6 47391.5 44428.0 48858.5 50040.7 50322.5 50929.7 40564.6 41966.0 42248.4 43127.8 43896.0 41368.2 41398.6 41797.8 42310.0 42967.0 40914.0 42411.4 42680.6 43314.0 43521.3 33949.5 36796.3 37310.0 37657.2 37673.2 28231.6 28273.4 28376.0 28542.0 28605.3 14:42:57 INFO - PROCESS | 9096 | 14:42:57 INFO - PROCESS | 9096 | [#2] jquery.html Cycles:180 Average:27301.88 Median:23276.65 stddev:69357.60 (298.0%) stddev-sans-first:69522.71 14:42:57 INFO - PROCESS | 9096 | Values: 382.5 383.6 388.6 401.7 413.0 14234.4 16540.8 18255.4 19887.8 19910.9 18079.5 18972.2 19210.7 19768.3 19831.9 5537.3 5539.7 5633.9 5634.2 5637.2 4091.1 5473.2 5616.7 5630.4 6088.6 6357.2 6370.0 6375.9 6384.1 6387.2 6216.3 6292.4 6348.7 6371.3 6374.7 5560.9 5577.0 5577.6 5580.7 5581.1 22320.3 22614.0 23224.0 23329.3 23554.0 2287.8 2584.7 2634.6 3046.0 3058.0 13693.8 13900.8 14344.4 14478.3 14785.6 1954.8 1964.3 1974.7 1982.1 2034.5 77371.0 77790.0 78400.0 78517.0 79389.0 10296.1 10413.9 10770.1 11107.2 11177.2 12901.5 13471.3 14445.7 14472.2 14913.1 7781.0 7926.0 7993.2 8170.8 8202.8 7638.2 7710.5 7779.5 7863.3 7896.1 6632.0 6682.4 6690.6 6767.7 6774.2 1862.5 1869.4 1873.9 1881.1 1941.1 908.2 988.5 992.6 993.7 1087.2 19231.0 19594.2 19667.3 19703.3 19913.0 1001.3 1010.5 1028.9 1054.6 1079.5 10937.5 11374.8 11391.9 11444.1 11447.4 353661.0 356605.0 356868.0 488949.0 495816.0 98921.5 101975.0 102295.5 103735.5 105973.0 1000.9 1003.6 1021.2 1023.9 1029.1 17462.0 18033.9 18331.9 18346.8 18723.3 42622.0 43171.4 43733.1 44391.0 44918.0 58183.0 60352.0 62446.0 63003.0 63017.7 8595.7 8656.4 8689.8 8881.9 8900.9 10131.0 13137.4 13188.8 13558.5 14000.7 11513.9 11917.6 12137.1 12203.1 12275.9 11705.2 11949.7 12063.6 12103.1 12360.6 7578.9 9288.6 12202.8 12500.9 12665.2 8496.7 8540.7 8551.8 8586.8 8614.4 9146.5 11816.8 12222.7 12276.8 12377.3 14:42:57 INFO - PROCESS | 9096 | 14:42:57 INFO - PROCESS | 9096 | [#3] mootools.html Cycles:180 Average:5878.58 Median:4238.28 stddev:3373.41 (79.6%) stddev-sans-first:3365.52 14:42:57 INFO - PROCESS | 9096 | Values: 1325.2 1470.0 1511.3 1645.9 1809.3 8380.0 8808.4 8849.5 9125.0 9138.8 8865.7 8982.3 9033.3 9062.9 9063.9 2030.2 2287.9 2357.7 2383.5 2384.8 2318.6 2391.2 2393.1 2393.5 2394.4 2375.2 2381.9 2403.4 2403.5 2404.6 2006.4 2271.6 2357.7 2362.5 2367.6 2059.9 2085.3 2091.8 2096.3 2111.8 8850.7 8900.7 8907.6 8912.0 8912.4 5258.8 5413.1 5414.4 5416.3 5420.3 3339.1 3345.4 3409.3 3416.8 3556.8 1021.0 1059.2 1061.6 1077.6 1083.3 11909.6 12086.3 12106.4 12111.6 12113.5 4632.0 4635.1 4772.6 4774.0 4783.7 10351.5 10379.5 10379.9 10381.1 10395.6 5217.8 5234.3 5272.9 5276.2 5281.2 4122.4 4812.1 4963.6 4968.9 5026.7 4026.9 4044.4 4068.4 4081.8 4094.4 1268.2 1276.1 1283.0 1286.9 1292.1 902.4 1018.6 1021.4 1027.2 1033.8 5964.9 6060.6 6128.6 6144.4 6144.7 977.1 992.8 994.6 1018.4 1038.9 4059.5 4147.1 4187.5 4229.8 4246.7 11119.2 11480.5 11502.0 11503.1 11517.6 11191.9 11269.9 11349.3 11359.3 11365.1 8012.8 8333.1 8380.8 8477.5 8485.1 5870.6 5914.2 5949.5 5950.3 5955.4 10157.5 10435.8 10553.8 10556.0 10572.4 10394.1 10426.9 10577.3 10639.4 10769.2 6400.7 7213.0 7438.7 7455.1 7597.5 8723.6 8745.7 8777.9 8819.5 8819.6 7634.6 7811.2 7833.4 7981.9 7984.9 7489.9 7750.3 7791.6 7972.0 7973.2 7045.2 7181.3 7282.0 7284.1 7285.6 5070.5 5092.3 5179.2 5232.5 5250.4 5009.8 5009.8 5102.1 5392.1 5431.1 14:42:57 INFO - PROCESS | 9096 | 14:42:57 INFO - PROCESS | 9096 | [#4] prototype.html Cycles:180 Average:4638.25 Median:5330.86 stddev:1362.04 (25.6%) stddev-sans-first:1326.76 14:42:57 INFO - PROCESS | 9096 | Values: 321.5 329.1 333.7 335.5 336.5 5254.2 5266.6 5272.6 5287.4 5383.4 5237.0 5255.4 5264.7 5272.2 5281.2 4138.6 4148.4 4159.9 4168.4 4171.2 3921.4 3945.9 4071.2 4098.6 4122.8 4029.8 4038.3 4057.9 4069.1 4075.6 3905.9 4064.6 4092.2 4113.6 4123.8 3550.4 3599.9 3603.4 3627.4 3641.4 5037.6 5038.4 5051.2 5058.7 5100.8 4605.7 4620.3 4628.7 4666.0 4694.3 5425.4 5447.1 5463.9 5469.8 5486.3 3947.6 3987.4 3994.7 4009.8 4015.4 5500.0 5754.3 5763.9 5771.2 5772.6 4051.7 4086.0 4106.1 4116.2 4119.5 4104.5 4123.3 4125.2 4137.8 4153.4 4672.7 4676.1 4684.9 4697.3 4712.2 5247.3 5434.6 5454.6 5470.2 5520.7 1392.9 1406.5 1418.4 1433.2 1437.7 890.9 920.1 931.4 939.2 943.4 4776.0 5121.1 5178.3 5341.5 5450.2 5716.3 5721.2 5727.2 5729.0 5742.8 5212.4 5352.5 5424.9 5466.0 5471.6 2987.3 2998.5 3000.3 3014.7 3019.7 5792.7 5821.3 5828.5 5833.3 5963.9 5649.4 5709.0 5782.4 5814.8 5824.2 5872.7 5878.2 5883.2 5902.7 5911.3 5411.9 5570.3 5672.8 5691.9 5699.3 5558.2 5584.8 5591.9 5595.8 5599.3 5740.9 5749.3 5814.1 5819.4 5888.6 3746.6 3977.6 4111.9 4117.2 4145.8 5587.1 5601.0 5604.9 5607.4 5644.4 5516.1 5542.5 5547.4 5551.6 5562.1 5388.7 5452.5 5464.2 5491.7 5552.9 5326.5 5335.2 5336.3 5390.0 5398.4 5252.1 5388.8 5426.7 5517.2 5574.2 5400.6 5421.1 5423.7 5439.8 5443.3 14:42:57 INFO - PROCESS | 9096 | 14:42:57 INFO - PROCESS | 9096 | [#5] yui.html Cycles:180 Average:20960.42 Median:4539.08 stddev:30127.83 (663.7%) stddev-sans-first:30173.98 14:42:57 INFO - PROCESS | 9096 | Values: 710.9 734.4 748.4 816.8 853.1 14602.0 14697.7 14791.2 14808.9 14829.7 12628.6 12635.9 12745.1 12763.0 13405.9 791.6 811.0 818.7 819.0 820.3 683.4 787.2 807.4 809.3 814.5 863.9 864.3 864.3 868.9 869.6 707.5 858.3 864.1 865.2 866.0 603.5 617.7 618.2 621.2 624.1 13323.7 13336.5 13345.5 13350.2 13363.7 14011.9 14598.1 14658.7 14730.5 15130.5 12850.0 12861.0 13119.0 13194.0 13646.6 4367.6 4526.2 4552.0 4564.1 4769.9 72588.6 73852.3 73929.6 74015.6 74355.0 11618.9 11689.2 11715.6 11854.5 12065.0 21828.3 21865.2 21926.0 21942.9 21987.8 7955.0 8085.4 8112.0 8238.3 8408.5 4760.9 4774.5 4783.4 4809.9 4899.6 3448.9 3587.4 3589.8 3590.0 3590.5 617.7 635.1 638.8 640.7 651.0 575.8 628.4 707.4 712.8 731.4 9696.2 9847.9 9963.0 10110.2 10150.2 589.0 624.8 644.8 645.5 659.4 4643.2 5211.1 5222.7 5300.9 5460.3 82848.4 119960.4 120819.0 122608.4 125249.4 71707.0 85768.6 104219.0 105463.0 105825.5 88123.6 90935.0 91649.5 93697.5 95932.5 10461.5 10507.4 10550.4 10698.3 10715.6 52133.2 52735.0 52924.5 54056.5 54504.5 71817.0 72456.3 78495.6 80310.4 80343.0 13412.3 13540.7 13559.7 13612.9 13858.1 14125.9 14295.8 14512.0 14586.3 14601.0 14411.0 14436.5 14844.8 15054.2 15326.2 13602.7 13639.7 13640.8 13667.2 13674.9 13157.1 13599.1 13671.8 13674.5 14050.4 11749.2 11911.3 11937.3 12062.9 12377.9 11784.9 11821.5 12039.9 12139.8 12192.1 14:42:57 INFO - PROCESS | 9096 | -------- Summary: end -------- 14:42:57 INFO - PROCESS | 9096 | 14:42:58 INFO - TEST-INFO | 9096: exit 0 14:42:58 INFO - TEST-OK | dromaeo_css | took 1113771ms 14:42:58 INFO - TEST-START | kraken 14:42:58 INFO - operating with platform_type : linux_ 14:42:58 INFO - Initialising browser for kraken test... 14:42:58 INFO - TEST-INFO | started process 9271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2lBmVI/profile http://localhost:44162/getInfo.html) 14:43:02 INFO - PROCESS | 9271 | __metrics Screen width/height:1600/1200 14:43:02 INFO - PROCESS | 9271 | colorDepth:24 14:43:02 INFO - PROCESS | 9271 | Browser inner width/height: 1024/697 14:43:02 INFO - PROCESS | 9271 | __metrics 14:43:03 ERROR - PROCESS | 9271 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:43:04 INFO - TEST-INFO | 9271: exit 0 14:43:04 INFO - Browser initialized. 14:43:04 INFO - Running cycle 1/1 for kraken test... 14:43:04 INFO - TEST-INFO | started process 9355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2lBmVI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:43:16 INFO - PROCESS | 9355 | RSS: Main: 156389376 14:43:16 INFO - PROCESS | 9355 | 14:43:18 INFO - PROCESS | 9355 | Cycle 1(1): loaded http://localhost:44162/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44162/tests/kraken/driver.html?testName=audio-beat-detection) 14:43:19 INFO - PROCESS | 9355 | RSS: Main: 214609920 14:43:19 INFO - PROCESS | 9355 | 14:43:22 INFO - PROCESS | 9355 | Cycle 1(1): loaded http://localhost:44162/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44162/tests/kraken/driver.html?testName=audio-dft) 14:43:22 INFO - PROCESS | 9355 | RSS: Main: 200876032 14:43:22 INFO - PROCESS | 9355 | 14:43:26 INFO - PROCESS | 9355 | Cycle 1(1): loaded http://localhost:44162/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44162/tests/kraken/driver.html?testName=audio-fft) 14:43:26 INFO - PROCESS | 9355 | RSS: Main: 268931072 14:43:26 INFO - PROCESS | 9355 | 14:43:28 INFO - PROCESS | 9355 | Cycle 1(1): loaded http://localhost:44162/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44162/tests/kraken/driver.html?testName=audio-oscillator) 14:43:29 INFO - PROCESS | 9355 | RSS: Main: 179367936 14:43:29 INFO - PROCESS | 9355 | 14:43:31 INFO - PROCESS | 9355 | Cycle 1(1): loaded http://localhost:44162/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44162/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:43:32 INFO - PROCESS | 9355 | RSS: Main: 183717888 14:43:32 INFO - PROCESS | 9355 | 14:43:35 INFO - PROCESS | 9355 | Cycle 1(1): loaded http://localhost:44162/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44162/tests/kraken/driver.html?testName=imaging-darkroom) 14:43:35 INFO - PROCESS | 9355 | RSS: Main: 220049408 14:43:35 INFO - PROCESS | 9355 | 14:43:39 INFO - PROCESS | 9355 | Cycle 1(1): loaded http://localhost:44162/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44162/tests/kraken/driver.html?testName=imaging-desaturate) 14:43:39 INFO - PROCESS | 9355 | RSS: Main: 220917760 14:43:39 INFO - PROCESS | 9355 | 14:43:42 INFO - PROCESS | 9355 | Cycle 1(1): loaded http://localhost:44162/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44162/tests/kraken/driver.html?testName=json-parse-financial) 14:43:43 INFO - PROCESS | 9355 | RSS: Main: 220332032 14:43:43 INFO - PROCESS | 9355 | 14:43:44 INFO - PROCESS | 9355 | Cycle 1(1): loaded http://localhost:44162/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44162/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:43:45 INFO - PROCESS | 9355 | RSS: Main: 206893056 14:43:45 INFO - PROCESS | 9355 | 14:43:47 INFO - PROCESS | 9355 | Cycle 1(1): loaded http://localhost:44162/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44162/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:43:47 INFO - PROCESS | 9355 | RSS: Main: 210423808 14:43:47 INFO - PROCESS | 9355 | 14:43:49 INFO - PROCESS | 9355 | Cycle 1(1): loaded http://localhost:44162/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44162/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:43:50 INFO - PROCESS | 9355 | RSS: Main: 217444352 14:43:50 INFO - PROCESS | 9355 | 14:43:53 INFO - PROCESS | 9355 | Cycle 1(1): loaded http://localhost:44162/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:43:53 INFO - PROCESS | 9355 | RSS: Main: 222777344 14:43:53 INFO - PROCESS | 9355 | 14:43:56 INFO - PROCESS | 9355 | Cycle 1(1): loaded http://localhost:44162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:43:57 INFO - PROCESS | 9355 | RSS: Main: 223416320 14:43:57 INFO - PROCESS | 9355 | 14:43:58 INFO - PROCESS | 9355 | Cycle 1(1): loaded http://localhost:44162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44162/tests/kraken/driver.html?testName=ai-astar) 14:43:59 INFO - PROCESS | 9355 | RSS: Main: 266035200 14:43:59 INFO - PROCESS | 9355 | 14:43:59 INFO - PROCESS | 9355 | __start_tp_report 14:43:59 INFO - PROCESS | 9355 | _x_x_mozilla_page_load 14:43:59 INFO - PROCESS | 9355 | _x_x_mozilla_page_load_details 14:43:59 INFO - PROCESS | 9355 | |i|pagename|runs| 14:43:59 INFO - PROCESS | 9355 | |0;ai-astar;111;104;110;109;109;112;110;110;111;110 14:43:59 INFO - PROCESS | 9355 | |1;audio-beat-detection;149;133;127;176;130;127;154;126;159;136 14:43:59 INFO - PROCESS | 9355 | |2;audio-dft;160;161;161;162;161;160;160;160;160;161 14:43:59 INFO - PROCESS | 9355 | |3;audio-fft;73;74;75;122;75;76;74;75;114;75 14:43:59 INFO - PROCESS | 9355 | |4;audio-oscillator;84;86;117;87;86;87;121;84;85;132 14:43:59 INFO - PROCESS | 9355 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;117;116;117 14:43:59 INFO - PROCESS | 9355 | |6;imaging-darkroom;145;146;144;146;146;145;145;146;146;146 14:43:59 INFO - PROCESS | 9355 | |7;imaging-desaturate;95;95;95;95;95;94;95;94;95;95 14:43:59 INFO - PROCESS | 9355 | |8;json-parse-financial;53;52;52;54;51;52;50;52;53;52 14:43:59 INFO - PROCESS | 9355 | |9;json-stringify-tinderbox;61;64;63;63;63;62;66;61;62;62 14:43:59 INFO - PROCESS | 9355 | |10;stanford-crypto-aes;79;78;79;80;80;81;81;80;112;80 14:43:59 INFO - PROCESS | 9355 | |11;stanford-crypto-ccm;131;137;131;122;130;127;133;136;132;126 14:43:59 INFO - PROCESS | 9355 | |12;stanford-crypto-pbkdf2;162;168;165;167;163;160;162;160;158;160 14:43:59 INFO - PROCESS | 9355 | |13;stanford-crypto-sha256-iterative;63;63;65;68;64;68;62;64;61;62 14:43:59 INFO - PROCESS | 9355 | __end_tp_report 14:43:59 INFO - PROCESS | 9355 | __start_cc_report 14:43:59 INFO - PROCESS | 9355 | _x_x_mozilla_cycle_collect,1670 14:43:59 INFO - PROCESS | 9355 | __end_cc_report 14:43:59 INFO - PROCESS | 9355 | __startTimestamp1465163039007__endTimestamp 14:43:59 INFO - PROCESS | 9355 | 14:43:59 INFO - PROCESS | 9355 | ------- Summary: start ------- 14:43:59 INFO - PROCESS | 9355 | Number of tests: 14 14:43:59 INFO - PROCESS | 9355 | 14:43:59 INFO - PROCESS | 9355 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:2.17 (2.0%) stddev-sans-first:2.24 14:43:59 INFO - PROCESS | 9355 | Values: 111.0 104.0 110.0 109.0 109.0 112.0 110.0 110.0 111.0 110.0 14:43:59 INFO - PROCESS | 9355 | 14:43:59 INFO - PROCESS | 9355 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:142.50 stddev:17.01 (11.9%) stddev-sans-first:17.84 14:43:59 INFO - PROCESS | 9355 | Values: 149.0 133.0 127.0 176.0 130.0 127.0 154.0 126.0 159.0 136.0 14:43:59 INFO - PROCESS | 9355 | 14:43:59 INFO - PROCESS | 9355 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 14:43:59 INFO - PROCESS | 9355 | Values: 160.0 161.0 161.0 162.0 161.0 160.0 160.0 160.0 160.0 161.0 14:43:59 INFO - PROCESS | 9355 | 14:43:59 INFO - PROCESS | 9355 | [#3] audio-fft Cycles:10 Average:83.30 Median:75.00 stddev:18.40 (24.5%) stddev-sans-first:19.14 14:43:59 INFO - PROCESS | 9355 | Values: 73.0 74.0 75.0 122.0 75.0 76.0 74.0 75.0 114.0 75.0 14:43:59 INFO - PROCESS | 9355 | 14:43:59 INFO - PROCESS | 9355 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:85.50 stddev:18.63 (21.8%) stddev-sans-first:19.17 14:43:59 INFO - PROCESS | 9355 | Values: 84.0 86.0 117.0 87.0 86.0 87.0 121.0 84.0 85.0 132.0 14:43:59 INFO - PROCESS | 9355 | 14:43:59 INFO - PROCESS | 9355 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:43:59 INFO - PROCESS | 9355 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 14:43:59 INFO - PROCESS | 9355 | 14:43:59 INFO - PROCESS | 9355 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 14:43:59 INFO - PROCESS | 9355 | Values: 145.0 146.0 144.0 146.0 146.0 145.0 145.0 146.0 146.0 146.0 14:43:59 INFO - PROCESS | 9355 | 14:43:59 INFO - PROCESS | 9355 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:43:59 INFO - PROCESS | 9355 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 14:43:59 INFO - PROCESS | 9355 | 14:43:59 INFO - PROCESS | 9355 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:1.10 (2.1%) stddev-sans-first:1.12 14:43:59 INFO - PROCESS | 9355 | Values: 53.0 52.0 52.0 54.0 51.0 52.0 50.0 52.0 53.0 52.0 14:43:59 INFO - PROCESS | 9355 | 14:43:59 INFO - PROCESS | 9355 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:1.49 (2.4%) stddev-sans-first:1.45 14:43:59 INFO - PROCESS | 9355 | Values: 61.0 64.0 63.0 63.0 63.0 62.0 66.0 61.0 62.0 62.0 14:43:59 INFO - PROCESS | 9355 | 14:43:59 INFO - PROCESS | 9355 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:80.00 stddev:10.23 (12.8%) stddev-sans-first:10.75 14:43:59 INFO - PROCESS | 9355 | Values: 79.0 78.0 79.0 80.0 80.0 81.0 81.0 80.0 112.0 80.0 14:43:59 INFO - PROCESS | 9355 | 14:43:59 INFO - PROCESS | 9355 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:131.50 stddev:4.55 (3.5%) stddev-sans-first:4.82 14:43:59 INFO - PROCESS | 9355 | Values: 131.0 137.0 131.0 122.0 130.0 127.0 133.0 136.0 132.0 126.0 14:43:59 INFO - PROCESS | 9355 | 14:43:59 INFO - PROCESS | 9355 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:162.50 stddev:3.27 (2.0%) stddev-sans-first:3.47 14:43:59 INFO - PROCESS | 9355 | Values: 162.0 168.0 165.0 167.0 163.0 160.0 162.0 160.0 158.0 160.0 14:43:59 INFO - PROCESS | 9355 | 14:43:59 INFO - PROCESS | 9355 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:2.40 (3.8%) stddev-sans-first:2.52 14:43:59 INFO - PROCESS | 9355 | Values: 63.0 63.0 65.0 68.0 64.0 68.0 62.0 64.0 61.0 62.0 14:43:59 INFO - PROCESS | 9355 | -------- Summary: end -------- 14:43:59 INFO - PROCESS | 9355 | 14:43:59 INFO - TEST-INFO | 9355: exit 0 14:43:59 INFO - TEST-OK | kraken | took 61245ms 14:43:59 INFO - SUITE-END | took 1175s 14:44:00 INFO - Completed test suite (00:19:35) 14:44:00 INFO - javascript benchmark 14:44:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.503439449688, 3105.5186446100856, 3111.844407779612, 3143.669914658962, 3169.857356418961, 5248.632595718292, 5320.920186197201, 5357.517823395893, 5410.702411367373, 5411.404745477994, 5299.125644268691, 5365.302510673617, 5409.513143817056, 5429.348478182614, 5504.284443022411, 4748.5251474852585, 4833.178359678863, 4852.951470485303, 4861.124997500448, 4967.279744437054, 4909.239067944474, 5010.924836127461, 5038.244263360489, 5045.4197767256865, 5093.617978651598, 4761.476237613842, 4809.831655892027, 4812.37439132914, 4936.136176169156, 4954.0, 4875.53682400175, 4877.463479017305, 4882.926756098661, 4892.559669629751, 4895.485973972717, 4826.541478559531, 4839.758012099381, 4840.15297322967, 4840.273958906157, 4866.172750632401, 5220.556252718524, 5260.736963151827, 5290.788368465257, 5302.681839089667, 5320.840374788762, 5748.655080695172, 5794.565407594405, 5795.797147099874, 5837.678927658977, 5843.444872737083, 5842.678652674102, 5864.853378665525, 5870.178175055496, 5873.0, 5877.529797616223, 5092.0, 5424.484673956007, 5429.837104886859, 5474.288342515448, 5479.0411677957, 6008.399160083956, 6024.427679370453, 6027.57806953509, 6029.8191054268445, 6042.939570604238, 5785.161151633074, 5793.449622285961, 5801.071828507418, 5802.187693722883, 5802.535797136219, 5578.30271216098, 5718.428157184248, 5797.420257974169, 5805.767769289266, 5881.882362352729, 5791.5656325775735, 5801.158831969341, 5804.709764511757, 5806.854828629318, 5808.070708686674, 5805.10020946754, 5807.390224026501, 5816.82549523515, 5819.6508209507565, 5819.709014549256, 4261.936070958938, 4273.700840941105, 4276.8289268429535, 4337.240982827992, 4338.652907767371, 3854.402567602026, 3912.276228897606, 3929.7445666031617, 3930.744501607386, 3932.8820135395986, 5399.919001214985, 5406.297181366397, 5406.756695948692, 5411.945880541223, 5476.890462190734, 5836.795712150054, 5842.532597392198, 5846.356900740915, 5878.441548052928, 5899.0, 5536.612437129443, 5546.584006199551, 5549.19536667181, 5551.916721249185, 5553.361363443175, 4900.632452566072, 4955.752212389366, 5002.974985125124, 5005.049040682332, 5028.673136246132, 5984.7606095756555, 5990.101484777319, 5994.700264986734, 6002.879942401128, 6005.189299444606, 5787.797427090031, 5802.390748971382, 5826.883462330815, 5827.737751801264, 5829.358770535323, 5853.473187413153, 5942.435468630473, 5983.072623743153, 6010.909836352545, 6042.093685947143, 5726.885462290814, 5726.9713651431475, 5729.770809167753, 5733.541316694738, 5739.827805165852, 5602.383737788921, 5816.21481100063, 5829.76680932758, 5830.53355731532, 5832.183494310885, 5613.045782217115, 5653.858653533694, 5691.0, 5712.37163911961, 5733.168690539765, 5677.602567820213, 5683.8010669626365, 5686.630369026166, 5687.77248910039, 5688.715564221855, 5355.22349259363, 5533.2253484513, 5552.333719953632, 5603.859903502445, 5611.354694210218, 5671.602987790815, 5790.044642634087, 5793.0, 5795.710214489174, 5797.2173756542325, 5596.636218645775, 5601.439856014366, 5607.859803504945, 5608.635438696635, 5609.691466969356], "value": 5332.412277710961, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.6694034810681, 620.5159975219325, 621.2079598511893, 631.7409861956598, 656.4354654996704, 34047.489287660705, 36888.44667329992, 36923.99999999996, 36940.44589331159, 44868.32697509532, 43437.0, 47945.760271198684, 48023.51976480234, 48119.51880481194, 48248.51751482484, 8724.38929274951, 8898.644054237822, 8908.287337013056, 8926.509042002688, 8931.464112153259, 8690.522021288827, 8829.028806831244, 8837.95581022094, 8843.469391836477, 8845.115488451136, 8853.24747396472, 8895.0, 8896.911030889672, 8900.109989001081, 8903.154200350957, 8829.381943263974, 8853.11468853116, 8871.512066836322, 8880.289576833839, 8882.11178882113, 8740.0, 8741.344399170088, 8743.519106449143, 8759.956200218958, 8825.338099642553, 43228.0, 43533.12933741308, 43728.781356093335, 43741.56258437406, 43751.96852361987, 3425.400554902907, 3623.873164439232, 4001.639852413297, 4161.604647558507, 4248.065425606362, 32576.837115814506, 33549.32901341984, 33607.49588756171, 33619.32761344784, 33760.49359259613, 4303.612674859278, 4334.501532323791, 4380.67144964129, 4382.17039684031, 4413.183561041185, 339211.0, 341620.0, 342255.0, 342581.0, 342596.0, 60546.394536054075, 60973.0, 61209.69395153085, 61291.693541532004, 61329.080063799076, 62821.0, 63080.47678092825, 63359.0, 63449.68275158595, 63493.36506634874, 15522.844771552365, 15549.378024879104, 15736.134512601917, 15760.76358854618, 15766.211689415484, 12103.515859365527, 12222.0, 12249.632511024683, 12256.754864902652, 12272.938635306766, 18263.360782372554, 18455.354062607745, 18623.44129676112, 18639.81360186408, 18693.439196824118, 5671.6597004179885, 5775.249217601685, 5836.299644042742, 5888.322842873039, 6066.666333351708, 958.5399008475971, 1032.9431881246453, 1071.223363061774, 1120.8542889424486, 1192.0761409907218, 33375.49936750951, 33547.17244264711, 33890.0, 33959.83020084884, 34161.0, 977.61384253221, 1077.7790552936629, 1146.6789298996293, 1147.002108165901, 1170.8185231289165, 17614.0, 17806.0, 17810.19854106568, 17875.462245019567, 17910.89404963615, 558451.0, 562404.0, 567221.0, 567838.0, 569414.0, 60234.0, 60479.09281360783, 60626.39373606208, 60640.09039864405, 60715.69642151849, 1259.200407741091, 1364.3860262881742, 1387.2924808347816, 1398.4476131927831, 1413.6889884225454, 30591.0, 34530.65469345274, 34746.47880281747, 34787.826060869535, 34946.051165184355, 51171.48828511667, 51498.48501514937, 51912.74043629758, 51978.48021519736, 51984.22023669572, 397136.0, 406959.0, 407237.0, 407672.0, 408208.0, 36528.81735591305, 37341.6265837349, 37930.775884049064, 42685.57314426816, 47391.52608473871, 44428.0, 48858.511414886816, 50040.749796250784, 50322.49677503178, 50929.745351273006, 40564.59435405726, 41966.0, 42248.36627450652, 43127.784361078, 43896.0, 41368.1726365465, 41398.58601414068, 41797.79101104596, 42310.0, 42967.0, 40914.0, 42411.363829543196, 42680.5731942689, 43314.0, 43521.34717979296, 33949.49075763915, 36796.26407471889, 37310.0, 37657.2468550622, 37673.246535068596, 28231.57652635253, 28273.37950894979, 28376.0, 28542.0, 28605.28486787847], "value": 20444.482532334754, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.45593442494663, 383.6278809554731, 388.5861557441323, 401.6726368010072, 413.0417431558783, 14234.359453824576, 16540.83459165408, 18255.36106236282, 19887.801121988774, 19910.90044549777, 18079.548011299692, 18972.214515042182, 19210.711839322386, 19768.30810921618, 19831.900840495815, 5537.280153580029, 5539.695316757577, 5633.915491267634, 5634.211210430543, 5637.154426835967, 4091.079507110906, 5473.233747275384, 5616.719164041802, 5630.40880707526, 6088.573799834014, 6357.173567436227, 6370.044493326015, 6375.904361434559, 6384.07430922516, 6387.233531976146, 6216.347283535254, 6292.433680968712, 6348.682565871711, 6371.331010243927, 6374.713137908759, 5560.888782224333, 5577.0, 5577.609567330289, 5580.748866301026, 5581.107022876361, 22320.330390088322, 22614.0, 23224.0, 23329.3001209964, 23554.0, 2287.7712228777154, 2584.6769153855766, 2634.5671142276606, 3046.025271912989, 3057.9541306880415, 13693.794593081111, 13900.791488127687, 14344.42622295107, 14478.348474318682, 14785.556433307018, 1954.8436125109956, 1964.3321270767865, 1974.6544354737864, 1982.0684278389133, 2034.4812072921459, 77371.0, 77789.99999999943, 78400.0, 78517.0, 79389.0, 10296.124829389437, 10413.9479302603, 10770.084542813793, 11107.222494425312, 11177.161712871404, 12901.483940642456, 13471.259080750457, 14445.711085778436, 14472.204028778518, 14913.105213687213, 7780.961095194488, 7926.0, 7993.241486872878, 8170.754877353689, 8202.794930126794, 7638.236176382317, 7710.537367757953, 7779.45543811939, 7863.33161681252, 7896.052473703192, 6632.0383544385795, 6682.431993280528, 6690.612716647792, 6767.72929082841, 6774.220964589135, 1862.5064357945155, 1869.4298239037225, 1873.8875667459995, 1881.130871680366, 1941.1361943934814, 908.246155690775, 988.48104745008, 992.6128809764198, 993.6919554937992, 1087.1737479515625, 19231.0, 19594.216231350587, 19667.311644092388, 19703.310384136486, 19913.0, 1001.329109496639, 1010.4745532323298, 1028.8713910761155, 1054.6256079091966, 1079.4926384599225, 10937.4531273436, 11374.772504549863, 11391.886081139248, 11444.141689373164, 11447.370394628375, 353661.0, 356605.0, 356868.0, 488949.0, 495816.0, 98921.50539247258, 101975.0, 102295.48852255692, 103735.48132259291, 105973.0, 1000.884898236712, 1003.6437064842022, 1021.1626466297713, 1023.9232057595561, 1029.0584115534202, 17462.0, 18033.92609849884, 18331.908340458212, 18346.816531835044, 18723.344682936033, 42622.0, 43171.35242971295, 43733.12533749371, 44391.0, 44918.0, 58183.0, 60352.0, 62446.0, 63003.0, 63017.68491157515, 8595.742127736177, 8656.437331573428, 8689.826203476021, 8881.866771998297, 8900.910990890008, 10131.0, 13137.408816603467, 13188.802167967297, 13558.525451609146, 14000.719985600435, 11513.942430287794, 11917.582884598998, 12137.089718271342, 12203.145779795685, 12275.93862030684, 11705.180637355645, 11949.701257468632, 12063.638090857288, 12103.092268080105, 12360.567380141652, 7578.924210757822, 9288.62845486173, 12202.81695774582, 12500.937495312466, 12665.240085594894, 8496.745097647081, 8540.658373664985, 8551.786205344915, 8586.78533036679, 8614.44006139624, 9146.542672866462, 11816.82274765862, 12222.694432639255, 12276.754464910473, 12377.257364558156], "value": 9438.268932972946, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.1717676452217, 1470.037125682678, 1511.297246780247, 1645.8518733314, 1809.294375193674, 8379.958100209498, 8808.42745221561, 8849.469031858085, 9124.954375228115, 9138.771530711736, 8865.734027979155, 8982.281417486602, 9033.277337812975, 9062.864057039133, 9063.864042039375, 2030.2386605023116, 2287.874166920819, 2357.7288611809604, 2383.4875501767115, 2384.8092152627746, 2318.5594737, 2391.222852572912, 2393.066703985447, 2393.5093305872256, 2394.3774618599205, 2375.2043065573052, 2381.940451488718, 2403.351095204294, 2403.5433267679086, 2404.5791986402396, 2006.3679940818595, 2271.5797577448225, 2357.65813956977, 2362.5393048355577, 2367.573836709392, 2059.855810093294, 2085.3431169181813, 2091.8117369436823, 2096.329174664108, 2111.7782632823487, 8850.690225842065, 8900.732978010605, 8907.643694252221, 8912.019677835433, 8912.376133670581, 5258.842234732964, 5413.052715774763, 5414.35027796667, 5416.268803711488, 5420.322459692538, 3339.1151344893624, 3345.3643807676463, 3409.2840503494294, 3416.8462419190946, 3556.8043757593323, 1020.9795804083951, 1059.2479339668844, 1061.6231237910508, 1077.6389909380366, 1083.3337497439097, 11909.583164589285, 12086.33525156116, 12106.394680265952, 12111.576094836639, 12113.45489452968, 4631.976840115778, 4635.119327327797, 4772.570468657837, 4774.0, 4783.689060211075, 10351.534180961875, 10379.481025948673, 10379.896201038044, 10381.065704086668, 10395.636152734769, 5217.8173763918085, 5234.2933703949475, 5272.868178295574, 5276.208568714646, 5281.234221038005, 4122.361034039729, 4812.133815913099, 4963.602911767122, 4968.925466118011, 5026.748662566857, 4026.898307329389, 4044.4337792709043, 4068.4100805383055, 4081.775502347399, 4094.3653733670735, 1268.1883594499527, 1276.074845736852, 1283.0, 1286.9356532173354, 1292.1213574769247, 902.4089221559889, 1018.592562974816, 1021.4331046269392, 1027.1782573940818, 1033.8087453820917, 5964.85087872798, 6060.606060606046, 6128.571000029955, 6144.354842741537, 6144.662043587646, 977.1059480575194, 992.7815880506278, 994.5524513968743, 1018.4449475036123, 1038.89611038897, 4059.512858456945, 4147.129102888427, 4187.45563076798, 4229.809658565372, 4246.745195288293, 11119.166062545342, 11480.483378247998, 11502.0, 11503.137264705181, 11517.596884109016, 11191.944040279746, 11269.9293567111, 11349.262297950607, 11359.261647992855, 11365.09079273656, 8012.79968000793, 8333.125021872738, 8380.832383352299, 8477.533735644598, 8485.0666426693, 5870.618409803349, 5914.2311499504785, 5949.494292985145, 5950.31571369298, 5955.3746856581165, 10157.492125393848, 10435.843462348223, 10553.841692374466, 10556.049955504042, 10572.41851698164, 10394.116500097274, 10426.895731042592, 10577.259591828806, 10639.361638301727, 10769.192310576582, 6400.679966001774, 7213.0, 7438.70245190208, 7455.105387353552, 7597.468177227541, 8723.563821808757, 8745.693900713444, 8777.868331974898, 8819.514926679094, 8819.559022049, 7634.618269086634, 7811.218878112143, 7833.37333013369, 7981.880271796043, 7984.92015079865, 7489.887651685338, 7750.341220996278, 7791.571463569559, 7972.0, 7973.242541958504, 7045.225025247116, 7181.317774811385, 7282.0, 7284.125904891447, 7285.562866228043, 5070.518300761421, 5092.287079808756, 5179.22311653255, 5232.502912223333, 5250.448702886142, 5009.799608015638, 5009.824656137018, 5102.1326374515675, 5392.08334583114, 5431.131019036935], "value": 4684.281719165891, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.455133548635, 329.06545411032664, 333.6930024377572, 335.485030478216, 336.50869730193915, 5254.238135470355, 5266.5786737061035, 5272.551833094191, 5287.360918115382, 5383.353997520303, 5236.973815130919, 5255.395629502608, 5264.710440925747, 5272.209168624709, 5281.155015197569, 4138.586141385867, 4148.419221309019, 4159.9376009359885, 4168.395582640515, 4171.207470580595, 3921.4313924481075, 3945.9210815783667, 4071.206114807599, 4098.631123198911, 4122.835086596532, 4029.81865816039, 4038.3336749436307, 4057.944934317084, 4069.1454794493043, 4075.6331930126285, 3905.8632947846972, 4064.5732198119217, 4092.1815636872598, 4113.6297733203855, 4123.835046598132, 3550.414181660023, 3599.8560057597665, 3603.387424137903, 3627.383344831385, 3641.4173732202985, 5037.647364684473, 5038.39539255288, 5051.2423136529815, 5058.671186372911, 5100.7959681613065, 4605.723656580582, 4620.2607582786595, 4628.685657171414, 4665.976670116627, 4694.29585562165, 5425.37608175057, 5447.12845944647, 5463.9180412293845, 5469.808556700536, 5486.31421072366, 3947.624975627311, 3987.4018897165365, 3994.660453861425, 4009.7794621295816, 4015.437838702584, 5500.047483143507, 5754.338251101093, 5763.9135412968835, 5771.153230966092, 5772.624779389368, 4051.736637118578, 4085.9591404085577, 4106.096658735073, 4116.156187981516, 4119.546849846514, 4104.486939132608, 4123.340265557496, 4125.154343359664, 4137.77242251679, 4153.397757325171, 4672.672912896132, 4676.134915040729, 4684.929726054112, 4697.342372067913, 4712.151812673683, 5247.2653828464045, 5434.619576629598, 5454.645448045864, 5470.206820011076, 5520.696361700145, 1392.8537503562184, 1406.521782593923, 1418.4113592858848, 1433.218895701845, 1437.7268319019563, 890.8708237305555, 920.0753242990752, 931.366670663955, 939.1594522901964, 943.3632298198826, 4776.0, 5121.103806833789, 5178.326817513699, 5341.545968592635, 5450.182472629137, 5716.28546431696, 5721.199032135504, 5727.169560413717, 5728.971355143198, 5742.827715168552, 5212.4266330703595, 5352.474544754727, 5424.891502169935, 5466.0, 5471.644343117685, 2987.3129180288656, 2998.4602771500904, 3000.349807605808, 3014.6533148687745, 3019.6980301970066, 5792.739326730307, 5821.301443826683, 5828.504577110993, 5833.329167145747, 5963.880722385528, 5649.350324712628, 5709.00277354384, 5782.392848750905, 5814.825555233349, 5824.242848429762, 5872.706364681749, 5878.235829342244, 5883.176355310346, 5902.734376953047, 5911.290645122613, 5411.945880541144, 5570.303712035996, 5672.837068401051, 5691.8861622768145, 5699.287589051369, 5558.221848941233, 5584.804531841366, 5591.8881622368135, 5595.832125036255, 5599.272094627835, 5740.885182296414, 5749.310082789924, 5814.122009605272, 5819.388964158702, 5888.587798854039, 3746.5878753337656, 3977.582353852804, 4111.8560850370095, 4117.22959127578, 4145.7719825409895, 5587.106063029895, 5600.983645887396, 5604.943950560605, 5607.43925607436, 5644.407337229532, 5516.089845175501, 5542.501174894279, 5547.4175211603815, 5551.583631227593, 5562.137868630369, 5388.703621300866, 5452.482014208644, 5464.23500709893, 5491.725413729378, 5552.917655879045, 5326.493983071602, 5335.2263921730355, 5336.332958380202, 5389.9759045781175, 5398.3791863934575, 5252.133397989289, 5388.811391601275, 5426.70153141581, 5517.227588137584, 5574.247476590608, 5400.62195646301, 5421.105517589711, 5423.674579525241, 5439.80324328647, 5443.292371991616], "value": 4203.96917573642, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.9360157585817, 734.434485446206, 748.3676293531967, 816.783552358625, 853.0914575976584, 14602.0, 14697.70604587909, 14791.186484743348, 14808.925955370236, 14829.703405931876, 12628.558000469986, 12635.936820315908, 12745.107842451009, 12763.0, 13405.865941340584, 791.5527726834334, 811.0389188811278, 818.7257268814955, 819.0253598218102, 820.3027426687298, 683.402023229674, 787.2363807107125, 807.4025221336199, 809.3363441977551, 814.4583851738587, 863.8790569320269, 864.3387808326635, 864.3430992445755, 868.9348298877578, 869.6173683579236, 707.4587940225731, 858.3390789092396, 864.0754392799707, 865.2126564825978, 865.9997702653445, 603.5171862510018, 617.6510271696523, 618.2056057965493, 621.1521273461692, 624.0670198053894, 13323.66690832737, 13336.466541338335, 13345.532906348231, 13350.19898806065, 13363.732725345535, 14011.929940350234, 14598.124112553282, 14658.70682586353, 14730.484433044792, 15130.54608361751, 12850.0, 12861.0, 13119.0, 13194.0, 13646.590602281849, 4367.578934838458, 4526.207913615104, 4551.954480455186, 4564.064366804797, 4769.928451073237, 72588.63705681438, 73852.26147738508, 73929.63035184843, 74015.62992185005, 74355.0, 11618.909322379392, 11689.240199387013, 11715.589954351728, 11854.525818967317, 12065.034797216202, 21828.345149645535, 21865.234716784835, 21926.0, 21942.89028554847, 21987.780122198572, 7954.960225198837, 8085.43401961857, 8111.95944020288, 8238.299744521662, 8408.453450525696, 4760.928586071212, 4774.474807771142, 4783.354247176587, 4809.879753006203, 4899.608031357483, 3448.8620455181513, 3587.443946188345, 3589.820508974593, 3590.0, 3590.479380489867, 617.7251123250111, 635.0632816595577, 638.8370965403885, 640.6828619833119, 650.9804705858832, 575.807104619957, 628.355935166449, 707.4199156691463, 712.7826013065961, 731.3637135691876, 9696.224302055818, 9847.901520984842, 9963.0, 10110.24173187014, 10150.238732095122, 588.9852753681192, 624.8406656302705, 644.8387903024244, 645.4961077474361, 659.4183770538384, 4643.210654188796, 5211.114110601131, 5222.712750798667, 5300.893982120413, 5460.290162278879, 82848.44333561712, 119960.40019799845, 120819.0, 122608.38695806642, 125249.37375313065, 71707.0, 85768.57115714507, 104219.0, 105463.0, 105825.47087264515, 88123.55938220269, 90935.0, 91649.54175229081, 93697.531512342, 95932.52033739787, 10461.529231184768, 10507.383945164891, 10550.366977981346, 10698.251122421356, 10715.624953126604, 52133.21800173076, 52735.0, 52924.47075529349, 54056.459435405144, 54504.454955451525, 71817.0, 72456.27543724496, 78495.60752196431, 80310.36275646959, 80343.0, 13412.262325571797, 13540.661483462993, 13559.661008474472, 13612.93193534026, 13858.099223550436, 14125.858741412865, 14295.785563216352, 14512.0, 14586.343614537584, 14601.0, 14411.0, 14436.474442141112, 14844.7773283403, 15054.172020538537, 15326.233688315762, 13602.727945441233, 13639.727205455636, 13640.79538806899, 13667.179969201481, 13674.949837938017, 13157.079004469595, 13599.076138897597, 13671.79492307636, 13674.453021879412, 14050.367733452224, 11749.177557571229, 11911.3448760319, 11937.28376297425, 12062.939685301517, 12377.938110309391, 11784.941075294568, 11821.468033938665, 12039.939800300943, 12139.75720485603, 12192.146549741788], "value": 7634.515565914718, "unit": "score"}], "name": "dromaeo_css", "value": 7326.901600313905, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 110.0, 109.0, 109.0, 112.0, 110.0, 110.0, 111.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 133.0, 127.0, 176.0, 130.0, 127.0, 154.0, 126.0, 159.0, 136.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 162.0, 161.0, 160.0, 160.0, 160.0, 160.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 122.0, 75.0, 76.0, 74.0, 75.0, 114.0, 75.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 117.0, 87.0, 86.0, 87.0, 121.0, 84.0, 85.0, 132.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 144.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 54.0, 51.0, 52.0, 50.0, 52.0, 53.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 63.0, 63.0, 63.0, 62.0, 66.0, 61.0, 62.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 80.0, 80.0, 81.0, 81.0, 80.0, 112.0, 80.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 137.0, 131.0, 122.0, 130.0, 127.0, 133.0, 136.0, 132.0, 126.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 165.0, 167.0, 163.0, 160.0, 162.0, 160.0, 158.0, 160.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 65.0, 68.0, 64.0, 68.0, 62.0, 64.0, 61.0, 62.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1503.9, "alertThreshold": 2.0}]} 14:44:00 INFO - Return code: 0 14:44:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:44:00 ERROR - # TBPL SUCCESS # 14:44:00 INFO - Running post-action listener: _resource_record_post_action 14:44:00 INFO - ##### 14:44:00 INFO - ##### Finished run-tests step (success) 14:44:00 INFO - ##### 14:44:00 INFO - Running post-run listener: _resource_record_post_run 14:44:00 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 348160; Write bytes: 294764544; Read time: 380; Write time: 266088 14:44:00 INFO - TinderboxPrint: CPU usage
13.1% 14:44:00 INFO - TinderboxPrint: I/O read bytes / time
348,160 / 380 14:44:00 INFO - TinderboxPrint: I/O write bytes / time
294,764,544 / 266,088 14:44:00 INFO - TinderboxPrint: CPU idle
8,272.3 (86.9%) 14:44:00 INFO - TinderboxPrint: CPU user
1,205.8 (12.7%) 14:44:00 INFO - TinderboxPrint: Swap in / out
0 / 0 14:44:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5443584; Read time: 0; Write time: 528 14:44:00 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 348160; Write bytes: 289320960; Read time: 380; Write time: 265560 14:44:00 INFO - Running post-run listener: _upload_blobber_files 14:44:00 INFO - Blob upload gear active. 14:44:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:44:00 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 14:44:00 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'] 14:44:00 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 14:44:01 INFO - (blobuploader) - INFO - Open directory for files ... 14:44:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:44:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:44:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:05 INFO - (blobuploader) - INFO - Done attempting. 14:44:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:44:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:44:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:05 INFO - (blobuploader) - INFO - Done attempting. 14:44:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:44:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:44:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:06 INFO - (blobuploader) - INFO - Done attempting. 14:44:06 INFO - (blobuploader) - INFO - Iteration through files over. 14:44:06 INFO - Return code: 0 14:44:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:44:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:44:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/635fc196b2d5df5d037a8ac50fbf28e5e37d157169ad336446c706972efd6c58470fa1adcf737bc5e994ff5aabdd717770ad31d2943cfcfac97c08ae1705c21b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14fcad12f8913d484ce2c8126a0ee68d95e31a83bb4896b07912f81d4833b0de554c8ed55580baa896d0f78a270d4461bfa6ec87ea996f6406e505892c6f41fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1ed636ff6da73692b9d2f93551db428180ea47a2dbfecdda5dd91c34476503f24c02d9eb6fcbd80169b89b0e0fe3b247d86c0fb1a683fa6b63cebcdbd9ed70a"} 14:44:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:44:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:44:06 INFO - Contents: 14:44:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/635fc196b2d5df5d037a8ac50fbf28e5e37d157169ad336446c706972efd6c58470fa1adcf737bc5e994ff5aabdd717770ad31d2943cfcfac97c08ae1705c21b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14fcad12f8913d484ce2c8126a0ee68d95e31a83bb4896b07912f81d4833b0de554c8ed55580baa896d0f78a270d4461bfa6ec87ea996f6406e505892c6f41fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1ed636ff6da73692b9d2f93551db428180ea47a2dbfecdda5dd91c34476503f24c02d9eb6fcbd80169b89b0e0fe3b247d86c0fb1a683fa6b63cebcdbd9ed70a"} 14:44:06 INFO - Running post-run listener: copy_logs_to_upload_dir 14:44:06 INFO - Copying logs to upload dir... 14:44:06 INFO - mkdir: /builds/slave/test/build/upload/logs 14:44:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.889750 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-05 14:44:06.648851) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 14:44:06.651896) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/635fc196b2d5df5d037a8ac50fbf28e5e37d157169ad336446c706972efd6c58470fa1adcf737bc5e994ff5aabdd717770ad31d2943cfcfac97c08ae1705c21b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14fcad12f8913d484ce2c8126a0ee68d95e31a83bb4896b07912f81d4833b0de554c8ed55580baa896d0f78a270d4461bfa6ec87ea996f6406e505892c6f41fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1ed636ff6da73692b9d2f93551db428180ea47a2dbfecdda5dd91c34476503f24c02d9eb6fcbd80169b89b0e0fe3b247d86c0fb1a683fa6b63cebcdbd9ed70a"} build_url:https://queue.taskcluster.net/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/DsZ4E4-XT0CijUL0Dog8xA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/635fc196b2d5df5d037a8ac50fbf28e5e37d157169ad336446c706972efd6c58470fa1adcf737bc5e994ff5aabdd717770ad31d2943cfcfac97c08ae1705c21b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14fcad12f8913d484ce2c8126a0ee68d95e31a83bb4896b07912f81d4833b0de554c8ed55580baa896d0f78a270d4461bfa6ec87ea996f6406e505892c6f41fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1ed636ff6da73692b9d2f93551db428180ea47a2dbfecdda5dd91c34476503f24c02d9eb6fcbd80169b89b0e0fe3b247d86c0fb1a683fa6b63cebcdbd9ed70a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 14:44:06.676611) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 14:44:06.676964) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1465159630.597174-2140245993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 14:44:06.760379) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 14:44:06.760713) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 14:44:06.760992) ========= ========= Total master_lag: 0.19 =========