builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1465768451.58 results: success (0) buildid: 20160612135259 builduid: 923d709e6e6146efad8bff56dde5249d revision: 370eaabb204751e618b049d7cbc0cc8298d7b2c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-12 14:54:11.579616) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-12 14:54:11.580125) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-12 14:54:11.580501) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-12 14:54:11.598790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 14:54:11.599118) ========= 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=af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-12 14:54:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.4M=0s 2016-06-12 14:54:12 (42.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107686 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 14:54:11.721037) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 14:54:11.721352) ========= 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=af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017544 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 14:54:11.770424) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 14:54:11.770799) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 370eaabb204751e618b049d7cbc0cc8298d7b2c9 --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 370eaabb204751e618b049d7cbc0cc8298d7b2c9 --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=af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-12 14:54:12,587 truncating revision to first 12 chars 2016-06-12 14:54:12,587 Setting DEBUG logging. 2016-06-12 14:54:12,587 attempt 1/10 2016-06-12 14:54:12,587 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/370eaabb2047?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-12 14:54:12,917 unpacking tar archive at: fx-team-370eaabb2047/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684258 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 14:54:12.468544) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-12 14:54:12.468875) ========= script_repo_revision: 370eaabb204751e618b049d7cbc0cc8298d7b2c9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-12 14:54:12.469255) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-12 14:54:12.469531) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-12 14:54:12.482449) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-12 14:54:12.482936) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:54:13 INFO - MultiFileLogger online at 20160612 14:54:13 in /builds/slave/test 14:54:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:54:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:54:13 INFO - {'append_to_log': False, 14:54:13 INFO - 'base_work_dir': '/builds/slave/test', 14:54:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:54:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:54:13 INFO - 'branch': 'Fx-Team-Non-PGO', 14:54:13 INFO - 'buildbot_json_path': 'buildprops.json', 14:54:13 INFO - 'config_files': ('talos/linux_config.py',), 14:54:13 INFO - 'default_actions': ('clobber', 14:54:13 INFO - 'read-buildbot-config', 14:54:13 INFO - 'download-and-extract', 14:54:13 INFO - 'populate-webroot', 14:54:13 INFO - 'create-virtualenv', 14:54:13 INFO - 'install', 14:54:13 INFO - 'run-tests'), 14:54:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:54:13 INFO - 'download_minidump_stackwalk': True, 14:54:13 INFO - 'download_symbols': 'ondemand', 14:54:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:54:13 INFO - 'tooltool.py': '/tools/tooltool.py', 14:54:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:54:13 INFO - '/tools/misc-python/virtualenv.py')}, 14:54:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:54:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:54:13 INFO - 'installer_path': 'installer.exe', 14:54:13 INFO - 'log_level': 'info', 14:54:13 INFO - 'log_name': 'talos', 14:54:13 INFO - 'log_to_console': True, 14:54:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:54:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:54:13 INFO - 'opt_config_files': (), 14:54:13 INFO - 'pip_index': False, 14:54:13 INFO - 'sps_profile': False, 14:54:13 INFO - 'sps_profile_interval': 0, 14:54:13 INFO - 'suite': 'dromaeojs-e10s', 14:54:13 INFO - 'system_bits': '32', 14:54:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:54:13 INFO - 'title': 'talos-linux64-ix-020', 14:54:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:54:13 INFO - 'use_talos_json': True, 14:54:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:54:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:54:13 INFO - 'work_dir': 'build'} 14:54:13 INFO - ##### 14:54:13 INFO - ##### Running clobber step. 14:54:13 INFO - ##### 14:54:13 INFO - Running pre-action listener: _resource_record_pre_action 14:54:13 INFO - Running main action method: clobber 14:54:13 INFO - rmtree: /builds/slave/test/build 14:54:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:54:13 INFO - Running post-action listener: _resource_record_post_action 14:54:13 INFO - ##### 14:54:13 INFO - ##### Finished clobber step (success) 14:54:13 INFO - ##### 14:54:13 INFO - ##### 14:54:13 INFO - ##### Running read-buildbot-config step. 14:54:13 INFO - ##### 14:54:13 INFO - Running pre-action listener: _resource_record_pre_action 14:54:13 INFO - Running main action method: read_buildbot_config 14:54:13 INFO - Using buildbot properties: 14:54:13 INFO - { 14:54:13 INFO - "project": "", 14:54:13 INFO - "product": "firefox", 14:54:13 INFO - "script_repo_revision": "production", 14:54:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:54:13 INFO - "repository": "", 14:54:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 14:54:13 INFO - "buildid": "20160612135259", 14:54:13 INFO - "pgo_build": "False", 14:54:13 INFO - "basedir": "/builds/slave/test", 14:54:13 INFO - "buildnumber": 1585, 14:54:13 INFO - "slavename": "talos-linux64-ix-020", 14:54:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:54:13 INFO - "platform": "ubuntu64_hw", 14:54:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:54:13 INFO - "branch": "fx-team", 14:54:13 INFO - "repo_path": "integration/fx-team", 14:54:13 INFO - "revision": "370eaabb204751e618b049d7cbc0cc8298d7b2c9", 14:54:13 INFO - "stage_platform": "linux64", 14:54:13 INFO - "builduid": "923d709e6e6146efad8bff56dde5249d", 14:54:13 INFO - "slavebuilddir": "test" 14:54:13 INFO - } 14:54:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:54:13 INFO - Running post-action listener: _resource_record_post_action 14:54:13 INFO - ##### 14:54:13 INFO - ##### Finished read-buildbot-config step (success) 14:54:13 INFO - ##### 14:54:13 INFO - ##### 14:54:13 INFO - ##### Running download-and-extract step. 14:54:13 INFO - ##### 14:54:13 INFO - Running pre-action listener: _resource_record_pre_action 14:54:13 INFO - Running main action method: download_and_extract 14:54:13 INFO - mkdir: /builds/slave/test/build/tests 14:54:13 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:54:13 INFO - https://queue.taskcluster.net/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:54:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:54:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:54:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:54:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:54:14 INFO - Downloaded 1361 bytes. 14:54:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:54:14 INFO - Using the following test package requirements: 14:54:14 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:54:14 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:54:14 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:54:14 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:14 INFO - u'jsshell-linux-x86_64.zip'], 14:54:14 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:54:14 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:54:14 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:54:14 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:54:14 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:54:14 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:54:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:54:14 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:54:14 INFO - https://queue.taskcluster.net/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:54:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:54:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:54:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:54:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:54:16 INFO - Downloaded 22891347 bytes. 14:54:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:54:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:54:17 INFO - Return code: 0 14:54:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:54:17 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:54:17 INFO - https://queue.taskcluster.net/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:54:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:54:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:54:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:54:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:54:19 INFO - Downloaded 22891347 bytes. 14:54:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:54:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:54:20 INFO - Return code: 0 14:54:20 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:54:20 INFO - https://queue.taskcluster.net/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:54:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:54:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:54:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:54:21 INFO - Downloaded 10833377 bytes. 14:54:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:54:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:54:21 INFO - Return code: 0 14:54:21 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:54:21 INFO - https://queue.taskcluster.net/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:54:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:54:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:54:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:54:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:54:25 INFO - Downloaded 55396295 bytes. 14:54:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:54:25 INFO - mkdir: /builds/slave/test/properties 14:54:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:54:25 INFO - Writing to file /builds/slave/test/properties/build_url 14:54:25 INFO - Contents: 14:54:25 INFO - build_url:https://queue.taskcluster.net/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:54:27 INFO - Running post-action listener: _resource_record_post_action 14:54:27 INFO - Running post-action listener: set_extra_try_arguments 14:54:27 INFO - ##### 14:54:27 INFO - ##### Finished download-and-extract step (success) 14:54:27 INFO - ##### 14:54:27 INFO - ##### 14:54:27 INFO - ##### Running populate-webroot step. 14:54:27 INFO - ##### 14:54:27 INFO - Running pre-action listener: _resource_record_pre_action 14:54:27 INFO - Running main action method: populate_webroot 14:54:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:54:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:54:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:54:27 INFO - '--tppagecycles', 14:54:27 INFO - '7'], 14:54:27 INFO - 'tests': ['tsvgm']}}, 14:54:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:54:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:54:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:54:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:54:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:54:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:54:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:27 INFO - 'talos_options': ['--disable-e10s'], 14:54:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:54:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:54:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:27 INFO - 'talos_options': ['--disable-e10s'], 14:54:27 INFO - 'tests': ['damp', 'tps']}, 14:54:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:27 INFO - 'tests': ['damp', 'tps']}, 14:54:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:54:27 INFO - 'tests': ['dromaeo_dom']}, 14:54:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:54:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:54:27 INFO - 'tests': ['a11yr', 14:54:27 INFO - 'ts_paint', 14:54:27 INFO - 'tpaint', 14:54:27 INFO - 'sessionrestore', 14:54:27 INFO - 'sessionrestore_no_auto_restore', 14:54:27 INFO - 'tabpaint']}, 14:54:27 INFO - 'other-e10s': {'tests': ['a11yr', 14:54:27 INFO - 'ts_paint', 14:54:27 INFO - 'tpaint', 14:54:27 INFO - 'sessionrestore', 14:54:27 INFO - 'sessionrestore_no_auto_restore', 14:54:27 INFO - 'tabpaint']}, 14:54:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:54:27 INFO - 'ts_paint', 14:54:27 INFO - 'tpaint', 14:54:27 INFO - 'sessionrestore', 14:54:27 INFO - 'sessionrestore_no_auto_restore', 14:54:27 INFO - 'tabpaint']}, 14:54:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:54:27 INFO - 'ts_paint', 14:54:27 INFO - 'tpaint', 14:54:27 INFO - 'sessionrestore', 14:54:27 INFO - 'sessionrestore_no_auto_restore', 14:54:27 INFO - 'tabpaint']}, 14:54:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:54:27 INFO - 'tests': ['a11yr', 14:54:27 INFO - 'ts_paint', 14:54:27 INFO - 'tpaint', 14:54:27 INFO - 'sessionrestore', 14:54:27 INFO - 'sessionrestore_no_auto_restore', 14:54:27 INFO - 'tabpaint']}, 14:54:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:54:27 INFO - 'tests': ['a11yr', 14:54:27 INFO - 'ts_paint', 14:54:27 INFO - 'tpaint', 14:54:27 INFO - 'sessionrestore', 14:54:27 INFO - 'sessionrestore_no_auto_restore', 14:54:27 INFO - 'tabpaint']}, 14:54:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:54:27 INFO - 'tests': ['tsvgx', 14:54:27 INFO - 'tsvgr_opacity', 14:54:27 INFO - 'tart', 14:54:27 INFO - 'tscrollx', 14:54:27 INFO - 'cart']}, 14:54:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:54:27 INFO - 'tsvgr_opacity', 14:54:27 INFO - 'tart', 14:54:27 INFO - 'tscrollx', 14:54:27 INFO - 'cart']}, 14:54:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:27 INFO - 'talos_options': ['--disable-e10s'], 14:54:27 INFO - 'tests': ['tp5o']}, 14:54:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:27 INFO - 'tests': ['tp5o']}, 14:54:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:27 INFO - 'talos_options': ['--disable-e10s', 14:54:27 INFO - '--xperf_path', 14:54:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:54:27 INFO - 'tests': ['tp5n']}, 14:54:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:27 INFO - 'talos_options': ['--xperf_path', 14:54:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:54:27 INFO - 'tests': ['tp5n']}}, 14:54:27 INFO - 'talos.zip': {'path': '', 14:54:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:54:27 INFO - Running post-action listener: _resource_record_post_action 14:54:27 INFO - ##### 14:54:27 INFO - ##### Finished populate-webroot step (success) 14:54:27 INFO - ##### 14:54:27 INFO - ##### 14:54:27 INFO - ##### Running create-virtualenv step. 14:54:27 INFO - ##### 14:54:27 INFO - Running pre-action listener: _resource_record_pre_action 14:54:27 INFO - Running main action method: create_virtualenv 14:54:27 INFO - Creating virtualenv /builds/slave/test/build/venv 14:54:27 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:54:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:54:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:54:27 INFO - Using real prefix '/usr' 14:54:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:54:28 INFO - Installing distribute.............................................................................................................................................................................................done. 14:54:30 INFO - Installing pip.................done. 14:54:30 INFO - Return code: 0 14:54:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:54:30 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:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:30 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:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:30 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 0x7f8df93b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1555350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e41c0>, '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 0x15e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e5550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', '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:54:30 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:54:30 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:54:30 INFO - Using env: {'DISPLAY': ':0', 14:54:30 INFO - 'HOME': '/home/cltbld', 14:54:30 INFO - 'LANG': 'en_US.UTF-8', 14:54:30 INFO - 'LANGUAGE': 'en_US:en', 14:54:30 INFO - 'LOGNAME': 'cltbld', 14:54:30 INFO - 'MAIL': '/var/mail/cltbld', 14:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:30 INFO - 'MOZ_NO_REMOTE': '1', 14:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:30 INFO - 'NO_EM_RESTART': '1', 14:54:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:30 INFO - 'PWD': '/builds/slave/test', 14:54:30 INFO - 'SHELL': '/bin/bash', 14:54:30 INFO - 'SHLVL': '1', 14:54:30 INFO - 'TERM': 'linux', 14:54:30 INFO - 'TMOUT': '86400', 14:54:30 INFO - 'USER': 'cltbld', 14:54:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', 14:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:30 INFO - '_': '/tools/buildbot/bin/python'} 14:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:30 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:54:30 INFO - Cleaning up... 14:54:30 INFO - Return code: 0 14:54:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:54:30 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:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:30 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:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:30 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 0x7f8df93b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1555350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e41c0>, '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 0x15e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e5550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', '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:54:30 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:54:30 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:54:30 INFO - Using env: {'DISPLAY': ':0', 14:54:30 INFO - 'HOME': '/home/cltbld', 14:54:30 INFO - 'LANG': 'en_US.UTF-8', 14:54:30 INFO - 'LANGUAGE': 'en_US:en', 14:54:30 INFO - 'LOGNAME': 'cltbld', 14:54:30 INFO - 'MAIL': '/var/mail/cltbld', 14:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:30 INFO - 'MOZ_NO_REMOTE': '1', 14:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:30 INFO - 'NO_EM_RESTART': '1', 14:54:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:30 INFO - 'PWD': '/builds/slave/test', 14:54:30 INFO - 'SHELL': '/bin/bash', 14:54:30 INFO - 'SHLVL': '1', 14:54:30 INFO - 'TERM': 'linux', 14:54:30 INFO - 'TMOUT': '86400', 14:54:30 INFO - 'USER': 'cltbld', 14:54:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', 14:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:30 INFO - '_': '/tools/buildbot/bin/python'} 14:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:30 INFO - Downloading/unpacking psutil>=3.1.1 14:54:30 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:54:30 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:54:30 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:54:30 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:54:30 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:54:30 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:54:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:54:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:54:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:54:32 INFO - Installing collected packages: psutil 14:54:32 INFO - Running setup.py install for psutil 14:54:32 INFO - building 'psutil._psutil_linux' extension 14:54:32 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:54:32 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:54:32 INFO - building 'psutil._psutil_posix' extension 14:54:32 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:54:33 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:54:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:54:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:54:33 INFO - Successfully installed psutil 14:54:33 INFO - Cleaning up... 14:54:33 INFO - Return code: 0 14:54:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:54: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:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:33 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 0x7f8df93b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1555350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e41c0>, '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 0x15e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e5550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', '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:54:33 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:54:33 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:54:33 INFO - Using env: {'DISPLAY': ':0', 14:54:33 INFO - 'HOME': '/home/cltbld', 14:54:33 INFO - 'LANG': 'en_US.UTF-8', 14:54:33 INFO - 'LANGUAGE': 'en_US:en', 14:54:33 INFO - 'LOGNAME': 'cltbld', 14:54:33 INFO - 'MAIL': '/var/mail/cltbld', 14:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:33 INFO - 'MOZ_NO_REMOTE': '1', 14:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:33 INFO - 'NO_EM_RESTART': '1', 14:54:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:33 INFO - 'PWD': '/builds/slave/test', 14:54:33 INFO - 'SHELL': '/bin/bash', 14:54:33 INFO - 'SHLVL': '1', 14:54:33 INFO - 'TERM': 'linux', 14:54:33 INFO - 'TMOUT': '86400', 14:54:33 INFO - 'USER': 'cltbld', 14:54:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', 14:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:33 INFO - '_': '/tools/buildbot/bin/python'} 14:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:54:33 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:54:33 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:54:33 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:54:33 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:54:33 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:54:33 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:54:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:54:35 INFO - Installing collected packages: mozsystemmonitor 14:54:35 INFO - Running setup.py install for mozsystemmonitor 14:54:35 INFO - Successfully installed mozsystemmonitor 14:54:35 INFO - Cleaning up... 14:54:35 INFO - Return code: 0 14:54:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:54:35 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:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:35 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:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:35 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 0x7f8df93b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1555350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e41c0>, '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 0x15e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e5550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', '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:54:35 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:54:35 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:54:35 INFO - Using env: {'DISPLAY': ':0', 14:54:35 INFO - 'HOME': '/home/cltbld', 14:54:35 INFO - 'LANG': 'en_US.UTF-8', 14:54:35 INFO - 'LANGUAGE': 'en_US:en', 14:54:35 INFO - 'LOGNAME': 'cltbld', 14:54:35 INFO - 'MAIL': '/var/mail/cltbld', 14:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:35 INFO - 'MOZ_NO_REMOTE': '1', 14:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:35 INFO - 'NO_EM_RESTART': '1', 14:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:35 INFO - 'PWD': '/builds/slave/test', 14:54:35 INFO - 'SHELL': '/bin/bash', 14:54:35 INFO - 'SHLVL': '1', 14:54:35 INFO - 'TERM': 'linux', 14:54:35 INFO - 'TMOUT': '86400', 14:54:35 INFO - 'USER': 'cltbld', 14:54:35 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', 14:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:35 INFO - '_': '/tools/buildbot/bin/python'} 14:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:35 INFO - Downloading/unpacking jsonschema==2.5.1 14:54:35 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:54:35 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:54:35 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:54:35 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:54:35 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:54:35 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:54:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:54:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:54:37 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:54:37 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:54:37 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:54:37 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:54:37 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:54:37 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:54:37 INFO - Downloading functools32-3.2.3-2.tar.gz 14:54:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:54:37 INFO - warning: no files found matching '*.txt' 14:54:37 INFO - no previously-included directories found matching 'build' 14:54:37 INFO - no previously-included directories found matching 'dist' 14:54:37 INFO - no previously-included directories found matching '.git*' 14:54:37 INFO - Installing collected packages: jsonschema, functools32 14:54:37 INFO - Running setup.py install for functools32 14:54:38 INFO - warning: no files found matching '*.txt' 14:54:38 INFO - no previously-included directories found matching 'build' 14:54:38 INFO - no previously-included directories found matching 'dist' 14:54:38 INFO - no previously-included directories found matching '.git*' 14:54:38 INFO - Successfully installed jsonschema functools32 14:54:38 INFO - Cleaning up... 14:54:38 INFO - Return code: 0 14:54:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:54: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:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:38 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 0x7f8df93b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1555350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e41c0>, '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 0x15e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e5550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', '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:54:38 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:54:38 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:54:38 INFO - Using env: {'DISPLAY': ':0', 14:54:38 INFO - 'HOME': '/home/cltbld', 14:54:38 INFO - 'LANG': 'en_US.UTF-8', 14:54:38 INFO - 'LANGUAGE': 'en_US:en', 14:54:38 INFO - 'LOGNAME': 'cltbld', 14:54:38 INFO - 'MAIL': '/var/mail/cltbld', 14:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:38 INFO - 'MOZ_NO_REMOTE': '1', 14:54:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:38 INFO - 'NO_EM_RESTART': '1', 14:54:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:38 INFO - 'PWD': '/builds/slave/test', 14:54:38 INFO - 'SHELL': '/bin/bash', 14:54:38 INFO - 'SHLVL': '1', 14:54:38 INFO - 'TERM': 'linux', 14:54:38 INFO - 'TMOUT': '86400', 14:54:38 INFO - 'USER': 'cltbld', 14:54:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', 14:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:38 INFO - '_': '/tools/buildbot/bin/python'} 14:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:38 INFO - Downloading/unpacking blobuploader==1.2.4 14:54:38 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:54:38 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:54:38 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:54:38 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:54:38 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:54:38 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:54:40 INFO - Downloading blobuploader-1.2.4.tar.gz 14:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:54:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:54:40 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:54:40 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:54:40 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:54:40 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:54:40 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:54:40 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:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:54:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:54:40 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:54:40 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:54:40 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:54:40 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:54:40 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:54:40 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:54:40 INFO - Downloading docopt-0.6.1.tar.gz 14:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:54:40 INFO - Installing collected packages: blobuploader, requests, docopt 14:54:40 INFO - Running setup.py install for blobuploader 14:54:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:54:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:54:41 INFO - Running setup.py install for requests 14:54:41 INFO - Running setup.py install for docopt 14:54:41 INFO - Successfully installed blobuploader requests docopt 14:54:41 INFO - Cleaning up... 14:54:41 INFO - Return code: 0 14:54:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:41 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 0x7f8df93b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1555350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e41c0>, '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 0x15e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e5550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', '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:54:41 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:54:41 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:54:41 INFO - Using env: {'DISPLAY': ':0', 14:54:41 INFO - 'HOME': '/home/cltbld', 14:54:41 INFO - 'LANG': 'en_US.UTF-8', 14:54:41 INFO - 'LANGUAGE': 'en_US:en', 14:54:41 INFO - 'LOGNAME': 'cltbld', 14:54:41 INFO - 'MAIL': '/var/mail/cltbld', 14:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:41 INFO - 'MOZ_NO_REMOTE': '1', 14:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:41 INFO - 'NO_EM_RESTART': '1', 14:54:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:41 INFO - 'PWD': '/builds/slave/test', 14:54:41 INFO - 'SHELL': '/bin/bash', 14:54:41 INFO - 'SHLVL': '1', 14:54:41 INFO - 'TERM': 'linux', 14:54:41 INFO - 'TMOUT': '86400', 14:54:41 INFO - 'USER': 'cltbld', 14:54:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', 14:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:41 INFO - '_': '/tools/buildbot/bin/python'} 14:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:54:41 INFO - Running setup.py (path:/tmp/pip-JfMep4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:54:41 INFO - Running setup.py (path:/tmp/pip-5GeZy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:54:41 INFO - Running setup.py (path:/tmp/pip-qn_2vH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:54:41 INFO - Running setup.py (path:/tmp/pip-8MtA6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:54:42 INFO - Running setup.py (path:/tmp/pip-CdYAe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:54:42 INFO - Running setup.py (path:/tmp/pip-NNT83Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:54:42 INFO - Running setup.py (path:/tmp/pip-lxJyuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:54:42 INFO - Running setup.py (path:/tmp/pip-qb8u85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:54:42 INFO - Running setup.py (path:/tmp/pip-oAqpEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:54:42 INFO - Running setup.py (path:/tmp/pip-5HnjKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:54:42 INFO - Running setup.py (path:/tmp/pip-KARwub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:54:42 INFO - Running setup.py (path:/tmp/pip-geJKDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:54:42 INFO - Running setup.py (path:/tmp/pip-D_4C9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:54:42 INFO - Running setup.py (path:/tmp/pip-weXMl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:42 INFO - Running setup.py (path:/tmp/pip-DdXJlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:54:42 INFO - Running setup.py (path:/tmp/pip-YZZU8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:54:42 INFO - Running setup.py (path:/tmp/pip-3jvhTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:54:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:54:42 INFO - Running setup.py install for manifestparser 14:54:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:54:43 INFO - Running setup.py install for mozcrash 14:54:43 INFO - Running setup.py install for mozdebug 14:54:43 INFO - Running setup.py install for mozdevice 14:54:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:54:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:54:43 INFO - Running setup.py install for mozfile 14:54:43 INFO - Running setup.py install for mozhttpd 14:54:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:54:43 INFO - Running setup.py install for mozinfo 14:54:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:54:43 INFO - Running setup.py install for mozInstall 14:54:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:54:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:54:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:54:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:54:43 INFO - Running setup.py install for mozleak 14:54:43 INFO - Running setup.py install for mozlog 14:54:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:54:44 INFO - Running setup.py install for moznetwork 14:54:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:54:44 INFO - Running setup.py install for mozprocess 14:54:44 INFO - Running setup.py install for mozprofile 14:54:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:54:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:54:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:54:44 INFO - Running setup.py install for mozrunner 14:54:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:54:44 INFO - Running setup.py install for mozscreenshot 14:54:44 INFO - Running setup.py install for moztest 14:54:44 INFO - Running setup.py install for mozversion 14:54:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:54:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:54:44 INFO - Cleaning up... 14:54:44 INFO - Return code: 0 14:54:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54: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:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:44 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 0x7f8df93b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1555350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e41c0>, '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 0x15e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e5550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', '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:54:44 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:54:44 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:54:44 INFO - Using env: {'DISPLAY': ':0', 14:54:44 INFO - 'HOME': '/home/cltbld', 14:54:44 INFO - 'LANG': 'en_US.UTF-8', 14:54:44 INFO - 'LANGUAGE': 'en_US:en', 14:54:44 INFO - 'LOGNAME': 'cltbld', 14:54:44 INFO - 'MAIL': '/var/mail/cltbld', 14:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:44 INFO - 'MOZ_NO_REMOTE': '1', 14:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:44 INFO - 'NO_EM_RESTART': '1', 14:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:44 INFO - 'PWD': '/builds/slave/test', 14:54:44 INFO - 'SHELL': '/bin/bash', 14:54:44 INFO - 'SHLVL': '1', 14:54:44 INFO - 'TERM': 'linux', 14:54:44 INFO - 'TMOUT': '86400', 14:54:44 INFO - 'USER': 'cltbld', 14:54:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', 14:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:44 INFO - '_': '/tools/buildbot/bin/python'} 14:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:54:44 INFO - Running setup.py (path:/tmp/pip-QTWMdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:54:45 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:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:54:45 INFO - Running setup.py (path:/tmp/pip-JQ6Ebj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:54:45 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:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:54:45 INFO - Running setup.py (path:/tmp/pip-flcBbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:54:45 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:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:54:45 INFO - Running setup.py (path:/tmp/pip-sWlUOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:54:45 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:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:54:45 INFO - Running setup.py (path:/tmp/pip-ksPTq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:54:45 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:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:54:45 INFO - Running setup.py (path:/tmp/pip-CWvN8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:54:45 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:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:54:45 INFO - Running setup.py (path:/tmp/pip-8_ltvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:54:45 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:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:54:45 INFO - Running setup.py (path:/tmp/pip-EVYFfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:54:45 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:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:54:45 INFO - Running setup.py (path:/tmp/pip-bPdL6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:54:45 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:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:54:45 INFO - Running setup.py (path:/tmp/pip-JIMU_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:54:45 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:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:54:45 INFO - Running setup.py (path:/tmp/pip-N6sHji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:54:45 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:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:54:45 INFO - Running setup.py (path:/tmp/pip-BICFuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:54:45 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:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:54:45 INFO - Running setup.py (path:/tmp/pip-dAzaV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:54:45 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:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:54:45 INFO - Running setup.py (path:/tmp/pip-Lxohum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:54:45 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:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:45 INFO - Running setup.py (path:/tmp/pip-60YhKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:46 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:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:54:46 INFO - Running setup.py (path:/tmp/pip-Y9X8zS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:54:46 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:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:54:46 INFO - Running setup.py (path:/tmp/pip-e2tmWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:54:46 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:54:46 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:54:46 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:54:46 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:54:46 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:54:46 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:54:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:54:46 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:54:46 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:54:46 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:54:46 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:54:46 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:54:46 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:54:48 INFO - Downloading blessings-1.6.tar.gz 14:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:54:48 INFO - Installing collected packages: blessings 14:54:48 INFO - Running setup.py install for blessings 14:54:48 INFO - Successfully installed blessings 14:54:48 INFO - Cleaning up... 14:54:48 INFO - Return code: 0 14:54:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:54:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:54:48 INFO - Reading from file tmpfile_stdout 14:54:48 INFO - Current package versions: 14:54:48 INFO - argparse == 1.2.1 14:54:48 INFO - blessings == 1.6 14:54:48 INFO - blobuploader == 1.2.4 14:54:48 INFO - docopt == 0.6.1 14:54:48 INFO - functools32 == 3.2.3-2 14:54:48 INFO - jsonschema == 2.5.1 14:54:48 INFO - manifestparser == 1.1 14:54:48 INFO - mozInstall == 1.12 14:54:48 INFO - mozcrash == 0.17 14:54:48 INFO - mozdebug == 0.1 14:54:48 INFO - mozdevice == 0.48 14:54:48 INFO - mozfile == 1.2 14:54:48 INFO - mozhttpd == 0.7 14:54:48 INFO - mozinfo == 0.9 14:54:48 INFO - mozleak == 0.1 14:54:48 INFO - mozlog == 3.2 14:54:48 INFO - moznetwork == 0.27 14:54:48 INFO - mozprocess == 0.22 14:54:48 INFO - mozprofile == 0.28 14:54:48 INFO - mozrunner == 6.11 14:54:48 INFO - mozscreenshot == 0.1 14:54:48 INFO - mozsystemmonitor == 0.3 14:54:48 INFO - moztest == 0.7 14:54:48 INFO - mozversion == 1.4 14:54:48 INFO - psutil == 3.1.1 14:54:48 INFO - requests == 1.2.3 14:54:48 INFO - wsgiref == 0.1.2 14:54:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54:48 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:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:48 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:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:48 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 0x7f8df93b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1555350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e41c0>, '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 0x15e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e5550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', '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:54:48 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:54:48 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:54:48 INFO - Using env: {'DISPLAY': ':0', 14:54:48 INFO - 'HOME': '/home/cltbld', 14:54:48 INFO - 'LANG': 'en_US.UTF-8', 14:54:48 INFO - 'LANGUAGE': 'en_US:en', 14:54:48 INFO - 'LOGNAME': 'cltbld', 14:54:48 INFO - 'MAIL': '/var/mail/cltbld', 14:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:48 INFO - 'MOZ_NO_REMOTE': '1', 14:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:48 INFO - 'NO_EM_RESTART': '1', 14:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:48 INFO - 'PWD': '/builds/slave/test', 14:54:48 INFO - 'SHELL': '/bin/bash', 14:54:48 INFO - 'SHLVL': '1', 14:54:48 INFO - 'TERM': 'linux', 14:54:48 INFO - 'TMOUT': '86400', 14:54:48 INFO - 'USER': 'cltbld', 14:54:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', 14:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:48 INFO - '_': '/tools/buildbot/bin/python'} 14:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:48 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:54:48 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:54:48 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:54:48 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:54:48 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:54:48 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:54:48 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:54:48 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:54:48 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:54:48 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:54:48 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:54:48 INFO - Cleaning up... 14:54:48 INFO - Return code: 0 14:54:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:54:48 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:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:48 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:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:48 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 0x7f8df93b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1555350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e41c0>, '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 0x15e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e5550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', '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:54:48 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:54:48 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:54:48 INFO - Using env: {'DISPLAY': ':0', 14:54:48 INFO - 'HOME': '/home/cltbld', 14:54:48 INFO - 'LANG': 'en_US.UTF-8', 14:54:48 INFO - 'LANGUAGE': 'en_US:en', 14:54:48 INFO - 'LOGNAME': 'cltbld', 14:54:48 INFO - 'MAIL': '/var/mail/cltbld', 14:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:48 INFO - 'MOZ_NO_REMOTE': '1', 14:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:48 INFO - 'NO_EM_RESTART': '1', 14:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:48 INFO - 'PWD': '/builds/slave/test', 14:54:48 INFO - 'SHELL': '/bin/bash', 14:54:48 INFO - 'SHLVL': '1', 14:54:48 INFO - 'TERM': 'linux', 14:54:48 INFO - 'TMOUT': '86400', 14:54:48 INFO - 'USER': 'cltbld', 14:54:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', 14:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:48 INFO - '_': '/tools/buildbot/bin/python'} 14:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:54:48 INFO - Cleaning up... 14:54:48 INFO - Return code: 0 14:54:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:54:48 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:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:48 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:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:48 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 0x7f8df93b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1555350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e41c0>, '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 0x15e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e5550>, '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': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', '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:54:48 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:54:48 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:54:48 INFO - Using env: {'DISPLAY': ':0', 14:54:48 INFO - 'HOME': '/home/cltbld', 14:54:48 INFO - 'LANG': 'en_US.UTF-8', 14:54:48 INFO - 'LANGUAGE': 'en_US:en', 14:54:48 INFO - 'LOGNAME': 'cltbld', 14:54:48 INFO - 'MAIL': '/var/mail/cltbld', 14:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:48 INFO - 'MOZ_NO_REMOTE': '1', 14:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:49 INFO - 'NO_EM_RESTART': '1', 14:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:49 INFO - 'PWD': '/builds/slave/test', 14:54:49 INFO - 'SHELL': '/bin/bash', 14:54:49 INFO - 'SHLVL': '1', 14:54:49 INFO - 'TERM': 'linux', 14:54:49 INFO - 'TMOUT': '86400', 14:54:49 INFO - 'USER': 'cltbld', 14:54:49 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', 14:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:49 INFO - '_': '/tools/buildbot/bin/python'} 14:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:49 INFO - Downloading/unpacking flake8 14:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:54:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:54:51 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:54:51 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:54:51 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:54:51 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:54:51 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:54:51 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:54:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:54:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:54:51 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:54:51 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:54:51 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:54:51 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:54:51 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:54:51 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:54:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:54:51 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:54:51 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:54:51 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:54:51 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:54:51 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:54:51 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:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:54:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:54:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:54:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:54:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:54:51 INFO - no previously-included directories found matching 'docs/_build' 14:54:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:54:51 INFO - Running setup.py install for pep8 14:54:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:54:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:54:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:54:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:54:51 INFO - no previously-included directories found matching 'docs/_build' 14:54:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:54:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:54:51 INFO - Cleaning up... 14:54:52 INFO - Return code: 0 14:54:52 INFO - Running post-action listener: _resource_record_post_action 14:54:52 INFO - Running post-action listener: _start_resource_monitoring 14:54:52 INFO - Starting resource monitoring. 14:54:52 INFO - ##### 14:54:52 INFO - ##### Finished create-virtualenv step (success) 14:54:52 INFO - ##### 14:54:52 INFO - ##### 14:54:52 INFO - ##### Running install step. 14:54:52 INFO - ##### 14:54:52 INFO - Running pre-action listener: _resource_record_pre_action 14:54:52 INFO - Running main action method: install 14:54:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:54:52 INFO - Reading from file tmpfile_stdout 14:54:52 INFO - Detecting whether we're running mozinstall >=1.0... 14:54:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:54:52 INFO - Reading from file tmpfile_stdout 14:54:52 INFO - Output received: 14:54:52 INFO - Usage: mozinstall [options] installer 14:54:52 INFO - Options: 14:54:52 INFO - -h, --help show this help message and exit 14:54:52 INFO - -d DEST, --destination=DEST 14:54:52 INFO - Directory to install application into. [default: 14:54:52 INFO - "/builds/slave/test"] 14:54:52 INFO - --app=APP Application being installed. [default: firefox] 14:54:52 INFO - mkdir: /builds/slave/test/build/application 14:54:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:55:08 INFO - Reading from file tmpfile_stdout 14:55:08 INFO - Output received: 14:55:08 INFO - /builds/slave/test/build/application/firefox/firefox 14:55:08 INFO - Running post-action listener: _resource_record_post_action 14:55:08 INFO - ##### 14:55:08 INFO - ##### Finished install step (success) 14:55:08 INFO - ##### 14:55:08 INFO - ##### 14:55:08 INFO - ##### Running run-tests step. 14:55:08 INFO - ##### 14:55:08 INFO - Running pre-action listener: _resource_record_pre_action 14:55:08 INFO - Running main action method: run_tests 14:55:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:55:08 INFO - Python 2.7.3 14:55:08 INFO - Return code: 0 14:55:08 INFO - grabbing minidump binary from tooltool 14:55:08 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:55:08 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 0x15e41c0>, '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 0x15e50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e5550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:55:08 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:55:08 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:55:08 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:55:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:55:08 INFO - Return code: 0 14:55:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:55:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:55:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:55:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:55:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:55:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:55:09 INFO - Return code: 0 14:55:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:55:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:55:09 INFO - Using env: {'DISPLAY': ':0', 14:55:09 INFO - 'HOME': '/home/cltbld', 14:55:09 INFO - 'LANG': 'en_US.UTF-8', 14:55:09 INFO - 'LANGUAGE': 'en_US:en', 14:55:09 INFO - 'LOGNAME': 'cltbld', 14:55:09 INFO - 'MAIL': '/var/mail/cltbld', 14:55:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:55:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:09 INFO - 'MOZ_NO_REMOTE': '1', 14:55:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:09 INFO - 'NO_EM_RESTART': '1', 14:55:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:09 INFO - 'PWD': '/builds/slave/test', 14:55:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:55:09 INFO - 'SHELL': '/bin/bash', 14:55:09 INFO - 'SHLVL': '1', 14:55:09 INFO - 'TERM': 'linux', 14:55:09 INFO - 'TMOUT': '86400', 14:55:09 INFO - 'USER': 'cltbld', 14:55:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085', 14:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:09 INFO - '_': '/tools/buildbot/bin/python'} 14:55:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:55:09 INFO - mozversion application_buildid: 20160612135259 14:55:09 INFO - mozversion application_changeset: 370eaabb204751e618b049d7cbc0cc8298d7b2c9 14:55:09 INFO - mozversion application_display_name: Nightly 14:55:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:55:09 INFO - mozversion application_name: Firefox 14:55:09 INFO - mozversion application_remotingname: firefox 14:55:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:55:09 INFO - mozversion application_vendor: Mozilla 14:55:09 INFO - mozversion application_version: 50.0a1 14:55:09 INFO - mozversion platform_buildid: 20160612135259 14:55:09 INFO - mozversion platform_changeset: 370eaabb204751e618b049d7cbc0cc8298d7b2c9 14:55:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:55:09 INFO - mozversion platform_version: 50.0a1 14:55:09 INFO - using testdate: 1465768509 14:55:09 INFO - actual date: 1465768509 14:55:09 INFO - starting webserver on 'localhost:41468' 14:55:09 INFO - SUITE-START | Running 2 tests 14:55:09 INFO - TEST-START | dromaeo_css 14:55:09 INFO - operating with platform_type : linux_ 14:55:09 INFO - Initialising browser for dromaeo_css test... 14:55:09 INFO - TEST-INFO | started process 26700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp765hqr/profile http://localhost:41468/getInfo.html) 14:55:14 INFO - PROCESS | 26700 | __metrics Screen width/height:1600/1200 14:55:14 INFO - PROCESS | 26700 | colorDepth:24 14:55:14 INFO - PROCESS | 26700 | Browser inner width/height: 1024/697 14:55:14 INFO - PROCESS | 26700 | __metrics 14:55:15 ERROR - PROCESS | 26700 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 14:55:16 INFO - TEST-INFO | 26700: exit 0 14:55:16 INFO - Browser initialized. 14:55:16 INFO - Running cycle 1/1 for dromaeo_css test... 14:55:16 INFO - TEST-INFO | started process 26817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp765hqr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:55:28 INFO - PROCESS | 26817 | RSS: Main: 185671680 14:55:28 INFO - PROCESS | 26817 | 14:56:18 INFO - PROCESS | 26817 | 1465768578246 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:58:30 INFO - PROCESS | 26817 | Cycle 1(1): loaded http://localhost:41468/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41468/tests/dromaeo/cssquery-ext.html) 14:58:31 INFO - PROCESS | 26817 | RSS: Main: 188567552 14:58:31 INFO - PROCESS | 26817 | 15:01:33 INFO - PROCESS | 26817 | Cycle 1(1): loaded http://localhost:41468/tests/dromaeo/cssquery-ext.html (next: http://localhost:41468/tests/dromaeo/cssquery-jquery.html) 15:01:34 INFO - PROCESS | 26817 | RSS: Main: 187498496 15:01:34 INFO - PROCESS | 26817 | 15:04:36 INFO - PROCESS | 26817 | Cycle 1(1): loaded http://localhost:41468/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41468/tests/dromaeo/cssquery-mootools.html) 15:04:37 INFO - PROCESS | 26817 | RSS: Main: 189067264 15:04:37 INFO - PROCESS | 26817 | 15:07:38 INFO - PROCESS | 26817 | Cycle 1(1): loaded http://localhost:41468/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41468/tests/dromaeo/cssquery-prototype.html) 15:07:39 INFO - PROCESS | 26817 | RSS: Main: 186355712 15:07:39 INFO - PROCESS | 26817 | 15:10:42 INFO - PROCESS | 26817 | Cycle 1(1): loaded http://localhost:41468/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41468/tests/dromaeo/cssquery-yui.html) 15:10:42 INFO - PROCESS | 26817 | RSS: Main: 187899904 15:10:42 INFO - PROCESS | 26817 | 15:13:45 INFO - PROCESS | 26817 | Cycle 1(1): loaded http://localhost:41468/tests/dromaeo/cssquery-yui.html (next: http://localhost:41468/tests/dromaeo/cssquery-dojo.html) 15:13:45 INFO - PROCESS | 26817 | RSS: Main: 189194240 15:13:45 INFO - PROCESS | 26817 | 15:13:45 INFO - PROCESS | 26817 | __start_tp_report 15:13:45 INFO - PROCESS | 26817 | _x_x_mozilla_page_load 15:13:45 INFO - PROCESS | 26817 | _x_x_mozilla_page_load_details 15:13:45 INFO - PROCESS | 26817 | |i|pagename|runs| 15:13:45 INFO - PROCESS | 26817 | |0;dojo.html;2609.217234829551;2663.9067632632855;2666.3067602423366;2674.531956907542;2690.973090269098;4775.928361074582;4782;4783.712977221365;4811.061842940628;4815.590674792638;4626.421697287839;4761.69049011814;4784.258439941806;4800.783964721587;4849.830255941043;4340.891477713051;4421.6683748718815;4464.843730469434;4476.306172543244;4513.909721805562;576.1000441090567;4317.13657268546;4318.352247162919;4350.042990542076;4410.603045725884;4354.477462704464;4390.165868484977;4396.032872767986;4398.406215160944;4450.421445212134;4388.561143885618;4398.582134697199;4429.446319210098;4432.977835110836;4435.068635586531;4312.870613881589;4352.7823608819435;4361.214981303364;4366.759828209447;4376.081022985177;4760.738159401231;4798.928016079762;4801.447833499123;4803.327534145223;4809.591184749301;4985;5090.160123579605;5151.871203219949;5163.32876726027;5193.065248255312;5118.053160165344;5171.715555644438;5174.068667639824;5175.792968281265;5180.948190518122;4851.417829860439;4853.757312134415;4854.271859221145;4859.198232291703;4911.042346742387;5284.128118860422;5294.655847369986;5313.495217954288;5331;5353.839384818461;5074.517920797518;5077.517635824591;5086.033653605803;5087;5088.389393272831;5178.61160412963;5190.896182076337;5193.195054766442;5194.454582268883;5202.2456743771945;4918.680285781413;5118.923216151761;5149.098907691139;5170.6122040847085;5180.326557547494;5123.87190320245;5153.3558305211845;5154.046501397253;5158.767855446514;5181.663191892515;4194.035371864488;4321.070969741458;4323.135372925428;4324.610785029363;4368.475782906072;3694.649008344203;3752.1932784451474;3773.132179598653;3788.052986753312;3806.1436176859984;4435.423394958635;4441.089576636782;4445.73325600465;4473.306637471197;4514.954850451519;5085.4914508548845;5096.541311282002;5098.821541246039;5130.7947682093045;5132.974335128375;4351.760653164107;4454.977725111354;4507.233770259064;4520.2315606347;4523.819047238074;4588.564086411786;4614.123316569841;4620.283856002325;4644.164050470948;4666.813327466931;4763.857084287477;4876.439209490883;4914.5822605078965;4925.852224433273;4967.155583550877;5160.638755287244;5179.19722443022;5214.191800270964;5219.739013049409;5220.3213582235585;4811.951880481291;4884.8046078157895;4915.631327650369;4934.654574179916;4970.577500912318;5093.134167191661;5107.029664363759;5144.125498665311;5149.330587023663;5149.845504634867;5190.273361729436;5233.241180028951;5233.973830130825;5236.109861323508;5274.077036518671;5073.264376665436;5085.491450855033;5092.3125378074965;5105.489451054865;5113.028524580318;4871.269309603588;4989.700617962933;5028.899422011466;5037.7733002014265;5061.367329083864;4978.4025916890205;4987.725675087905;5005.1241032819835;5014.197728363444;5055.797768089235;5056.317397151338;5105.081085404663;5108.055009823194;5109.3613298337705;5118.181091025418;4859.028194361213;4917.237828136645;4972.2790195422185;4994.2508623706735;5004.249362595494 15:13:45 INFO - PROCESS | 26817 | |1;ext.html;536.7290060172738;582.8688545077358;590.2592246730353;608.2427377914496;612.5773216480625;37631.43552846706;38712.22575548488;41483.377749333784;41491;41515.377269340985;41444.37833432493;41583;41652.37521437181;41815.79092104535;42077;7741.264579864904;7880.842383152333;7881.60591970402;7936.404769642271;7938.16649251826;7779.7666070017995;7796.76609701707;7811.101723301807;7914.643841027168;7916.485428447161;7828.334591559725;7898.526088434713;7915.366770658334;7919.24767147123;7920.722774702886;7882.290593846553;7901.525908445512;7903.604819758989;7936.841263174733;7950.363970882316;7819.2180781921925;7861.606919653995;7881.054273487218;7886.171951945078;7936.246056624669;39131;39204.60795392067;39213.41179882304;39408.21183576341;39609.40585891214;2515.7861581765574;2901.1586639874413;2968.257935516121;3386.2211691311136;3672.816359182057;27979.580306295422;28237.717622823715;28904.132876013755;28924;29402.852985734935;3317.9170520736934;3406.199543107368;3415.9316813663586;3422.401079811023;3472.166679996808;219348;221036;221338;222180;222617;32560.511592326133;32755.836220818743;32978.3404331912;32981.50527742086;33039.3392132156;33571.16072098168;34818.82590587031;35170.12074698153;35198;35345.116372090386;13514.39185236647;13659;13795.793063104062;13821.308934553232;13832.654183645489;10254.333468324536;10314.742131446774;10317.123044541147;10345.741356465998;10348.327358721659;7954.482958607672;7970.40221983342;7992.320652744465;8074.919250807534;8115.147909469539;3089.258577941278;3125.9218519537194;3176;3178.1577881861326;3193.3294008258526;853.117023880281;872.7556284240422;892.8839250897472;894.4007514964859;914.8307563100848;28199.43601128007;28541.429171416872;28623.14130576086;28673.56989645157;28890.42219155647;922.801597656507;948.7390967483859;959.788846453793;961.4567769210514;984.7488890332919;14432.927835360755;15112.168830714416;15155.696886062438;15309.693806123814;15475.922620387051;121405;123256;125100;369083;369905;49873.50126498761;50652.49347506478;50746.746266268434;50789.49210507922;50906.74546627317;1133.3369978562632;1149.373591392693;1153.296489141623;1161.7444162284285;1162.4943149729895;26851.32871678224;27439.176824695292;27982.160535183975;28595.571066434437;28669.426611468072;44391.77804110959;44429.33355999598;44508.332375015045;44689.32966005577;44705;331078;332230;333110;333547.3322633468;333941;25778.613320800578;25796.226113216635;26125.477490450463;26278.605820913082;26869;42218;42579;43122.353164701926;43339;43620;36696.26607467889;36826.8158659205;36890.8155459221;37059.81470092632;37254;36302.45546316754;36670.633293667786;36741.816290918374;36748.63251367452;37353.0661733448;32542.51186232161;37342.626573735004;37352.62647373491;37464;38446.423303649906;31939.201519962186;32972.1756956078;33114.834425827714;33400.49899251562;33416.33167336688;25637.48725025452;26229.868850655625;26290.605640915783;26311.342216444744;26439.33901652474 15:13:45 INFO - PROCESS | 26817 | |2;jquery.html;372.218341482886;375.2850819189444;387.08068337697966;398.1678292368948;404.5287240364973;15194.623103291695;16605.33578656854;16735;16831.83168168318;17005.404810831624;16173;16278.883745113148;17035.744463833053;17102;17116.914415427906;3426.0920855973063;4536.4329458817565;4765.380500534926;4771.212749896263;4790.664653474259;5286.920696189561;5625.156226566007;5627.465390787868;5629.4652008059165;5644.6613203207735;5469.15228139639;5570.053090974544;5588.776448942038;5609.158626206061;6057.242844644419;5895.823125306248;5965.194698715662;6054.212952316215;6058.727357268934;6068.6965651717455;4741.2651039089;5091.61812864033;5101.7194054327;5245.554127899133;5288.603354748409;12484.250944943242;12566.434510447052;12654.620361389174;12795.296258705768;18550;1909.3648378531584;1938.6413513499906;1984.0377416952767;1997.510609900569;2058.835293176542;8825.514596697243;9167.954160229156;9339.673111441067;9636.614535418576;9716.465594392306;1644.128611835717;1665.3338664534162;1729.5519114788392;1773.9379121730678;1853.7034074548142;47552.524474755155;66334.33665663378;66343.66828165877;66714.66642666805;67251.327486725;10116.190704743603;10333.276670633133;10372.170226381872;10837.024667779937;11094.389808560607;14250.786238206436;14271.714565708628;14272;14286.357113929898;14365.425382984564;7377.926220737724;7478.663460144307;7636.08366995964;7706.691732330756;7724.6523906424345;7181.569105853561;7276.272372762682;7392.96303518479;7402.407807375397;7488.737894173787;3937.1338305572726;4344.717593356421;4402.757848318309;4466.687331886802;4482.46210454741;1734.7137722275936;1785.4554360919785;1816.8455681266976;1820.7815062192622;1849.842763365129;795.3478147918767;844.7127976488024;877.3376101043672;917.0554329041098;937.5921474158627;15983.28075236594;16168.595785105466;16449.848510604144;16510.17449127539;16746.74879876803;826.7643721539332;834.4325858416214;837.4891316297054;840.4369072721291;840.7309660908451;8340.791480213044;9207.40151890125;9276.536173191313;9339.486328252011;9361.4383137012;381455;390896;395013;405052;407894;75666;78358.21641783623;78428;80549.19450805534;81285.59357203176;861.4271509446148;912.7991841794794;917.9495127767904;930.2418528898926;934.4860326820221;15263.923680381971;15333.233338333263;15378.461753838563;15387.923060384626;15679.686406271583;34163;35305.47041794324;35559.81549152385;36346.8182659085;36645.450318244715;47480;51198;51766.223506646675;52923.20615190698;54303.72848135892;7818.921810782047;7936.920630793618;8030.317423018875;8044.4771089881315;8087.069986951576;11502.654920352403;11962.222455540363;12134.393280336124;12193.69515762113;12591.748165036832;9765.658201962897;10339.431331276852;10423.166146708094;10441.112505437122;10446.52990615409;10392.272540922062;10569.894301056891;10584.523696433525;10621.309614875008;10796.352218866894;10728.409937453203;10796.89203107959;10809.0812280957;10860.348379097279;10961.177911656498;6766.15423072116;7845.9607701963405;7893.881591776013;7959.880601791094;7989.400794940519;7814.374850012099;9304.627814887328;9361.719148425558;9393.624255029723;9642.325037247325 15:13:45 INFO - PROCESS | 26817 | |3;mootools.html;1366.166638350606;1395.0374241773175;1461.04301682398;1644.3833562414102;1645.1774112943529;6871.828204294895;7421;7505.324520793128;8012.038555373356;8073.192680731924;7392.815179620498;7563.168051514343;7642;7712.845743085149;7714.190010048948;2211.458192742776;2263.0155882191216;2264.071730590458;2264.6036943534896;2271.1483193802324;2184.202765990418;2221.522372689871;2248.213125406103;2248.9437764055947;2257.2551058150852;2245.438640339915;2251.997860951877;2258.119333459952;2261.1294651559188;2263.3323169664905;2198.2416066457045;2208.723909511303;2213.1258153029544;2223.144089525528;2230.0745190745984;2164.891755412223;2188.518525924294;2188.5513469738667;2189.6606026065983;2192.0574153114153;7738.496997695188;7764.223577642247;7766.10689770678;7775.222477752236;7785.610719464004;4670;4787.760611969387;4800.735959522225;4812.590929770974;4828.0585285869265;2683.2755156107937;3025.9394812103633;3028.2732144285433;3034.605501284841;3042.5284080967485;891.741394995457;918.2011649864594;931.78568929146;940.8965013848472;946.2193690205607;10636;10897.618583349624;10900.781984360348;10935.945320273428;10951.123910087173;4235.4917409911;4306.590873866978;4392.560743925582;4415.977920110443;4423.756693381895;9231.538423078819;9357.39176953496;9385.812283754423;9392.107749763762;9399.342046056847;4737.242041273448;4798.904021919542;4827.25177597473;4848.0788650156355;4866.6350023747655;3744.02655309616;4168.687348448879;4294.506131794884;4354.455693038371;4438.245498265303;3770.2271034437877;3816.809159542012;3873.0704630888386;3902.048975512244;3977.8607748728655;1222.6882145052955;1258.3205069262497;1272.9299888506036;1282.7434513097419;1284.7687416265162;666.3403230801568;801.2988634944423;816.1104396208043;836.5775283481925;846.8602680557639;5114.28400023997;5161.74191290434;5285.392179899361;5323.733813309319;5368.4631536846;406.46143859386433;410.61197168675915;412.6863583676367;415.2815628961913;416.50227977567124;3437.470420317977;3524.875162749886;3566.5006899034156;3569.8929032129076;3588.102974256436;9549.9045009549;9887.258455615858;9918.752031199278;9925.30522863407;9935.701928942144;9749.610015599297;9833.901660983442;9838.950805245928;9845.212383009342;9858.507074646239;7402.851942961111;7472.505498900242;7496.25037496246;7497.10034795828;7500.099988001475;5184.351956005499;5319.175527793198;5339.492748188916;5412.972935135456;5451.836444906659;8920.687775927812;8932.776680583038;8980.955095224483;9200.585973631336;9227.077292270988;9020.278377729897;9137.680181193626;9148.359614826899;9178.495182765013;9183.403078799856;6060.787872424444;6409.102725618324;6601;6845.520813543004;6869.896951545631;7519.812004699927;7600.315971562365;7632.045994250719;7636.770896873103;7714.729984450517;6799.3200679931615;7011.3339232772805;7061.611611361219;7141.500094993301;7148.785536433916;6887.104676392037;6890.345417185359;6910.654467276717;7001.684924178322;7007.229204787572;5757.481826635623;5940.584159108821;5992.610480318765;6314.463270622048;6383.106365108795;4419.712718673276;4479.776011199362;4518.322251662145;4614.192516309699;4714.717116972993;4570.428696412949;4593.494715581351;4625.560571745679;4650.9767451162525;4692.9530704692515 15:13:45 INFO - PROCESS | 26817 | |4;prototype.html;298.4061717182807;306.75153125967967;308.19868342309996;311.2328111205877;312.4111050669489;4847.49101344359;4876.171050921343;5078.365204349457;5114.284000239964;5117.130087885059;4917.803287868481;4929.507049295069;4964.751762411883;4969.105560999019;4970.577500912418;3937.684985201177;3945.8618948336816;3957.1887763008513;3965.9405108923247;3982.0443093657605;3712.164762928333;3965.4051892216253;3971;4002.939955900664;4003.519577650686;3856.633619806114;3872.1287710265105;3886.145048089416;3891.7081218908697;3894;3853.2678791029894;3855.63371479709;3864.6908247340425;3865.246276975991;3899.688024958011;3262.054004338739;3377.5946886373545;3379.104537297618;3392.898213053588;3393.151712071982;4866.732329721864;4872.3909511311085;4877.780499877514;4897.681650692729;4906.828261010847;4434.733915965053;4460.643148548108;4464.6874718769695;4481.619062379702;4520.09598080382;5042.167952356236;5215.217717342429;5238.580913526908;5274.446183150791;5279.128943724281;3746.463949780577;3760.849566017356;3770.5286839145106;3773.4528493368307;3782.111203867089;5500.779968801243;5545.611807173499;5562.972185139089;5565.471280228372;5579.246801681802;3764.981175094107;3835.5589107252463;3855.151866589346;3871;3886.417037444406;3822.7384962962155;3835.865744698978;3841.673457756122;3844.9231015379537;3845.1732877431486;4368.08270263242;4369.427006277738;4390.1878152541885;4400.581944715311;4404.955950440454;5152.299741085433;5212.7914883405;5224.2947202127225;5250.606204534599;5260.28986086881;1185.6206014075412;1316.2694704439127;1335.6927906581345;1341.7920222365549;1343.43575698207;828.0725587342095;828.9419740618099;847.8643417053365;853.1681610429781;857.1728282207699;4147.502299724052;4180.038591124058;4197.433346498245;4214.346776249687;4236.703430759817;4729.834455794031;4779.880502987384;4858.319835223072;4859.441164266084;4875;4097.508299004138;4145.66834653227;4154.480689913761;4158.542560318362;4163.791810409467;2443.547943630434;2595.260350800013;2612.542805009116;2627.356297707074;2633.9464214314044;4516;4547.613452856544;4558.2251017327135;4565.840195593139;4568.588827005586;4858.708477491362;4870.9269360959615;4874.268859671078;4896.804127834918;4938.555530002245;4430.224710675619;4455.819207909906;4599.4710608280475;4620.653450991189;4631.305304204397;4762.618990480684;4769.2130798417875;4797.4482934461585;4798.47216806144;4847.587955023862;4683.508231635629;4708.270218116198;4714.292856071616;4727.834525791581;4741.288806678887;4607.516210797952;4690.1792186366565;5157.426984769681;5187.507186817246;5237;3808.2383523296007;3827.158025234444;3827.827747751302;3834.8274327654763;3843.2121415110396;5237.214417837355;5524.922640085145;5529.889402212014;5530.198121272473;5559.610827242054;5190.922136168036;5292.682439053669;5295.947040529545;5302.655327403706;5304.257403963526;5286.62993590445;5287.863109431491;5296.973515132399;5319.281896943863;5330.8933821324135;4935.605151587936;5188.662736922088;5209.635325527177;5212.530872221519;5245.239440281214;5217.269582258563;5288.762005709676;5300.310959575385;5318.787248510016;5372.045375043788;5240.868978275574;5243.8164664236565;5247.379308277276;5252.608058864327;5266 15:13:45 INFO - PROCESS | 26817 | |5;yui.html;622.2408661433052;649.8732747114309;668.2982867988611;728.4281838756575;738.7746737245142;12508.186967847096;13574.728505429897;13591.79612305815;13603.251821149834;13607.319634018284;12176.634700958963;12342.81485777714;12460.252384856914;12784.42470088846;12822.230666160038;622.3900577434117;768.7155752371602;770.9421793365492;779.3726050529322;782.9491083079581;768.7271018788333;768.8731359325733;769.1347234361343;774.8256642255503;778.6846327237449;833.7998880268722;836.1972506393869;837.6314421654483;838.0990435282066;842.3050982939069;828.204923273658;832.9125441828642;833.0752864320599;834.5410024486539;838.9035260944978;600.2287061126475;608.3186830749589;608.7838817219912;609.2171559546007;609.7926704920349;13499.460021599125;13634.727305453835;13640.317984100855;13657.590272291747;13679.521216757366;13350;13535;13549.187048777007;13794;13960.232187229698;10450.24736674109;10640.627578034731;10643.57425702971;10710.41092739899;10792.51433685486;3332.500124981272;3382.6617338266224;3386.4243078676686;3395.151212196951;3430.382531144393;61250;61580.69209653923;62471.375286247014;64319.67840160769;64577.67711161414;10679.679609611723;10804.405757683402;10821.621243256448;10957.06864916475;11026.062784663232;20110.39668809938;20111;20153.294634687714;20277.29029483961;20282.89858550727;7247.23903990084;7286.817829554304;7306.525075870051;7367.079115110611;7545.584992825447;3871.6515513603913;3957.920841583152;4013.8394464221687;4023.4166045923175;4072.857449989236;2998.205475548981;3105.6428510721103;3116.25209949615;3119.9704097647723;3123.6095488063993;525.8343621759134;555.4334578729673;559.8096647139911;568.2669356530113;569.1775384569257;534.180033648348;562.2493970549363;570.2729020498897;646.4860435953428;647.6729251727942;7803.726869559651;7945.364370850318;8110.756677299691;8132.878006829902;8354.665813367397;510.08185266520115;578.9739461724232;595.7378753348513;599.9392088177126;620.9720562574695;3681.9263614727556;3696.537932758405;3784.3566593679143;3791.450239715226;3853.1715681128694;57017.42982570121;57065.71467142721;57108;57170;88723.55638221768;50278.49721502811;61319.08021379683;65749;76858.6157069211;77387.61306193433;71429.64285178541;71637;72567.63716181491;73631.26368736244;74443.62778186075;7524.774256772305;7598.468107232441;7620.783593053569;7687;7777.3778097753175;43569;43616.56383436125;43843.342349865416;43964.560354396046;44046.33930490981;58228.12657810221;61691.383086168564;61750.38249617446;62366;62589.37410625836;8941.731748047569;10327.535260913126;10334.328268662513;10454.268201225841;10464.843027354444;10819.783604328028;10922.945385273022;11143.108551315712;11327.207095503565;11346.829797552879;9811.607535698493;9952.25358098131;10080.747981300527;10441.060304572626;10517.789644207227;10085.848712269175;10144.594216231268;10153.949230253802;10235.641752538922;10340.948295258475;9874.802503950024;10067.29528932997;10079.596816127567;10526.315789473965;10612.893871061191;8903.554822258991;8934.776630584287;9068.365214434927;9158.771030724285;9475.099865512766;8422.634150224381;8538.13223402548;8627.784305392415;8647;8765.737027889174 15:13:45 INFO - PROCESS | 26817 | __end_tp_report 15:13:45 INFO - PROCESS | 26817 | __start_cc_report 15:13:45 INFO - PROCESS | 26817 | _x_x_mozilla_cycle_collect,390 15:13:45 INFO - PROCESS | 26817 | __end_cc_report 15:13:45 INFO - PROCESS | 26817 | __startTimestamp1465769625691__endTimestamp 15:13:45 INFO - PROCESS | 26817 | 15:13:45 INFO - PROCESS | 26817 | ------- Summary: start ------- 15:13:45 INFO - PROCESS | 26817 | Number of tests: 6 15:13:45 INFO - PROCESS | 26817 | 15:13:45 INFO - PROCESS | 26817 | [#0] dojo.html Cycles:165 Average:4741.24 Median:4917.24 stddev:611.53 (12.4%) stddev-sans-first:590.09 15:13:45 INFO - PROCESS | 26817 | Values: 2609.2 2663.9 2666.3 2674.5 2691.0 4775.9 4782.0 4783.7 4811.1 4815.6 4626.4 4761.7 4784.3 4800.8 4849.8 4340.9 4421.7 4464.8 4476.3 4513.9 576.1 4317.1 4318.4 4350.0 4410.6 4354.5 4390.2 4396.0 4398.4 4450.4 4388.6 4398.6 4429.4 4433.0 4435.1 4312.9 4352.8 4361.2 4366.8 4376.1 4760.7 4798.9 4801.4 4803.3 4809.6 4985.0 5090.2 5151.9 5163.3 5193.1 5118.1 5171.7 5174.1 5175.8 5180.9 4851.4 4853.8 4854.3 4859.2 4911.0 5284.1 5294.7 5313.5 5331.0 5353.8 5074.5 5077.5 5086.0 5087.0 5088.4 5178.6 5190.9 5193.2 5194.5 5202.2 4918.7 5118.9 5149.1 5170.6 5180.3 5123.9 5153.4 5154.0 5158.8 5181.7 4194.0 4321.1 4323.1 4324.6 4368.5 3694.6 3752.2 3773.1 3788.1 3806.1 4435.4 4441.1 4445.7 4473.3 4515.0 5085.5 5096.5 5098.8 5130.8 5133.0 4351.8 4455.0 4507.2 4520.2 4523.8 4588.6 4614.1 4620.3 4644.2 4666.8 4763.9 4876.4 4914.6 4925.9 4967.2 5160.6 5179.2 5214.2 5219.7 5220.3 4812.0 4884.8 4915.6 4934.7 4970.6 5093.1 5107.0 5144.1 5149.3 5149.8 5190.3 5233.2 5234.0 5236.1 5274.1 5073.3 5085.5 5092.3 5105.5 5113.0 4871.3 4989.7 5028.9 5037.8 5061.4 4978.4 4987.7 5005.1 5014.2 5055.8 5056.3 5105.1 5108.1 5109.4 5118.2 4859.0 4917.2 4972.3 4994.3 5004.2 15:13:45 INFO - PROCESS | 26817 | 15:13:45 INFO - PROCESS | 26817 | [#1] ext.html Cycles:180 Average:41207.31 Median:20184.54 stddev:72036.82 (356.9%) stddev-sans-first:72174.18 15:13:45 INFO - PROCESS | 26817 | Values: 536.7 582.9 590.3 608.2 612.6 37631.4 38712.2 41483.4 41491.0 41515.4 41444.4 41583.0 41652.4 41815.8 42077.0 7741.3 7880.8 7881.6 7936.4 7938.2 7779.8 7796.8 7811.1 7914.6 7916.5 7828.3 7898.5 7915.4 7919.2 7920.7 7882.3 7901.5 7903.6 7936.8 7950.4 7819.2 7861.6 7881.1 7886.2 7936.2 39131.0 39204.6 39213.4 39408.2 39609.4 2515.8 2901.2 2968.3 3386.2 3672.8 27979.6 28237.7 28904.1 28924.0 29402.9 3317.9 3406.2 3415.9 3422.4 3472.2 219348.0 221036.0 221338.0 222180.0 222617.0 32560.5 32755.8 32978.3 32981.5 33039.3 33571.2 34818.8 35170.1 35198.0 35345.1 13514.4 13659.0 13795.8 13821.3 13832.7 10254.3 10314.7 10317.1 10345.7 10348.3 7954.5 7970.4 7992.3 8074.9 8115.1 3089.3 3125.9 3176.0 3178.2 3193.3 853.1 872.8 892.9 894.4 914.8 28199.4 28541.4 28623.1 28673.6 28890.4 922.8 948.7 959.8 961.5 984.7 14432.9 15112.2 15155.7 15309.7 15475.9 121405.0 123256.0 125100.0 369083.0 369905.0 49873.5 50652.5 50746.7 50789.5 50906.7 1133.3 1149.4 1153.3 1161.7 1162.5 26851.3 27439.2 27982.2 28595.6 28669.4 44391.8 44429.3 44508.3 44689.3 44705.0 331078.0 332230.0 333110.0 333547.3 333941.0 25778.6 25796.2 26125.5 26278.6 26869.0 42218.0 42579.0 43122.4 43339.0 43620.0 36696.3 36826.8 36890.8 37059.8 37254.0 36302.5 36670.6 36741.8 36748.6 37353.1 32542.5 37342.6 37352.6 37464.0 38446.4 31939.2 32972.2 33114.8 33400.5 33416.3 25637.5 26229.9 26290.6 26311.3 26439.3 15:13:45 INFO - PROCESS | 26817 | 15:13:45 INFO - PROCESS | 26817 | [#2] jquery.html Cycles:180 Average:24169.76 Median:4638.85 stddev:65331.63 (1408.4%) stddev-sans-first:65490.47 15:13:45 INFO - PROCESS | 26817 | Values: 372.2 375.3 387.1 398.2 404.5 15194.6 16605.3 16735.0 16831.8 17005.4 16173.0 16278.9 17035.7 17102.0 17116.9 3426.1 4536.4 4765.4 4771.2 4790.7 5286.9 5625.2 5627.5 5629.5 5644.7 5469.2 5570.1 5588.8 5609.2 6057.2 5895.8 5965.2 6054.2 6058.7 6068.7 4741.3 5091.6 5101.7 5245.6 5288.6 12484.3 12566.4 12654.6 12795.3 18550.0 1909.4 1938.6 1984.0 1997.5 2058.8 8825.5 9168.0 9339.7 9636.6 9716.5 1644.1 1665.3 1729.6 1773.9 1853.7 47552.5 66334.3 66343.7 66714.7 67251.3 10116.2 10333.3 10372.2 10837.0 11094.4 14250.8 14271.7 14272.0 14286.4 14365.4 7377.9 7478.7 7636.1 7706.7 7724.7 7181.6 7276.3 7393.0 7402.4 7488.7 3937.1 4344.7 4402.8 4466.7 4482.5 1734.7 1785.5 1816.8 1820.8 1849.8 795.3 844.7 877.3 917.1 937.6 15983.3 16168.6 16449.8 16510.2 16746.7 826.8 834.4 837.5 840.4 840.7 8340.8 9207.4 9276.5 9339.5 9361.4 381455.0 390896.0 395013.0 405052.0 407894.0 75666.0 78358.2 78428.0 80549.2 81285.6 861.4 912.8 917.9 930.2 934.5 15263.9 15333.2 15378.5 15387.9 15679.7 34163.0 35305.5 35559.8 36346.8 36645.5 47480.0 51198.0 51766.2 52923.2 54303.7 7818.9 7936.9 8030.3 8044.5 8087.1 11502.7 11962.2 12134.4 12193.7 12591.7 9765.7 10339.4 10423.2 10441.1 10446.5 10392.3 10569.9 10584.5 10621.3 10796.4 10728.4 10796.9 10809.1 10860.3 10961.2 6766.2 7846.0 7893.9 7959.9 7989.4 7814.4 9304.6 9361.7 9393.6 9642.3 15:13:45 INFO - PROCESS | 26817 | 15:13:45 INFO - PROCESS | 26817 | [#3] mootools.html Cycles:180 Average:5195.79 Median:5138.01 stddev:2930.83 (57.0%) stddev-sans-first:2924.93 15:13:45 INFO - PROCESS | 26817 | Values: 1366.2 1395.0 1461.0 1644.4 1645.2 6871.8 7421.0 7505.3 8012.0 8073.2 7392.8 7563.2 7642.0 7712.8 7714.2 2211.5 2263.0 2264.1 2264.6 2271.1 2184.2 2221.5 2248.2 2248.9 2257.3 2245.4 2252.0 2258.1 2261.1 2263.3 2198.2 2208.7 2213.1 2223.1 2230.1 2164.9 2188.5 2188.6 2189.7 2192.1 7738.5 7764.2 7766.1 7775.2 7785.6 4670.0 4787.8 4800.7 4812.6 4828.1 2683.3 3025.9 3028.3 3034.6 3042.5 891.7 918.2 931.8 940.9 946.2 10636.0 10897.6 10900.8 10935.9 10951.1 4235.5 4306.6 4392.6 4416.0 4423.8 9231.5 9357.4 9385.8 9392.1 9399.3 4737.2 4798.9 4827.3 4848.1 4866.6 3744.0 4168.7 4294.5 4354.5 4438.2 3770.2 3816.8 3873.1 3902.0 3977.9 1222.7 1258.3 1272.9 1282.7 1284.8 666.3 801.3 816.1 836.6 846.9 5114.3 5161.7 5285.4 5323.7 5368.5 406.5 410.6 412.7 415.3 416.5 3437.5 3524.9 3566.5 3569.9 3588.1 9549.9 9887.3 9918.8 9925.3 9935.7 9749.6 9833.9 9839.0 9845.2 9858.5 7402.9 7472.5 7496.3 7497.1 7500.1 5184.4 5319.2 5339.5 5413.0 5451.8 8920.7 8932.8 8981.0 9200.6 9227.1 9020.3 9137.7 9148.4 9178.5 9183.4 6060.8 6409.1 6601.0 6845.5 6869.9 7519.8 7600.3 7632.0 7636.8 7714.7 6799.3 7011.3 7061.6 7141.5 7148.8 6887.1 6890.3 6910.7 7001.7 7007.2 5757.5 5940.6 5992.6 6314.5 6383.1 4419.7 4479.8 4518.3 4614.2 4714.7 4570.4 4593.5 4625.6 4651.0 4693.0 15:13:45 INFO - PROCESS | 26817 | 15:13:45 INFO - PROCESS | 26817 | [#4] prototype.html Cycles:180 Average:4233.06 Median:4657.41 stddev:1233.02 (26.5%) stddev-sans-first:1200.59 15:13:45 INFO - PROCESS | 26817 | Values: 298.4 306.8 308.2 311.2 312.4 4847.5 4876.2 5078.4 5114.3 5117.1 4917.8 4929.5 4964.8 4969.1 4970.6 3937.7 3945.9 3957.2 3965.9 3982.0 3712.2 3965.4 3971.0 4002.9 4003.5 3856.6 3872.1 3886.1 3891.7 3894.0 3853.3 3855.6 3864.7 3865.2 3899.7 3262.1 3377.6 3379.1 3392.9 3393.2 4866.7 4872.4 4877.8 4897.7 4906.8 4434.7 4460.6 4464.7 4481.6 4520.1 5042.2 5215.2 5238.6 5274.4 5279.1 3746.5 3760.8 3770.5 3773.5 3782.1 5500.8 5545.6 5563.0 5565.5 5579.2 3765.0 3835.6 3855.2 3871.0 3886.4 3822.7 3835.9 3841.7 3844.9 3845.2 4368.1 4369.4 4390.2 4400.6 4405.0 5152.3 5212.8 5224.3 5250.6 5260.3 1185.6 1316.3 1335.7 1341.8 1343.4 828.1 828.9 847.9 853.2 857.2 4147.5 4180.0 4197.4 4214.3 4236.7 4729.8 4779.9 4858.3 4859.4 4875.0 4097.5 4145.7 4154.5 4158.5 4163.8 2443.5 2595.3 2612.5 2627.4 2633.9 4516.0 4547.6 4558.2 4565.8 4568.6 4858.7 4870.9 4874.3 4896.8 4938.6 4430.2 4455.8 4599.5 4620.7 4631.3 4762.6 4769.2 4797.4 4798.5 4847.6 4683.5 4708.3 4714.3 4727.8 4741.3 4607.5 4690.2 5157.4 5187.5 5237.0 3808.2 3827.2 3827.8 3834.8 3843.2 5237.2 5524.9 5529.9 5530.2 5559.6 5190.9 5292.7 5295.9 5302.7 5304.3 5286.6 5287.9 5297.0 5319.3 5330.9 4935.6 5188.7 5209.6 5212.5 5245.2 5217.3 5288.8 5300.3 5318.8 5372.0 5240.9 5243.8 5247.4 5252.6 5266.0 15:13:45 INFO - PROCESS | 26817 | 15:13:45 INFO - PROCESS | 26817 | [#5] yui.html Cycles:180 Average:16063.94 Median:28793.85 stddev:21529.24 (74.8%) stddev-sans-first:21558.41 15:13:45 INFO - PROCESS | 26817 | Values: 622.2 649.9 668.3 728.4 738.8 12508.2 13574.7 13591.8 13603.3 13607.3 12176.6 12342.8 12460.3 12784.4 12822.2 622.4 768.7 770.9 779.4 782.9 768.7 768.9 769.1 774.8 778.7 833.8 836.2 837.6 838.1 842.3 828.2 832.9 833.1 834.5 838.9 600.2 608.3 608.8 609.2 609.8 13499.5 13634.7 13640.3 13657.6 13679.5 13350.0 13535.0 13549.2 13794.0 13960.2 10450.2 10640.6 10643.6 10710.4 10792.5 3332.5 3382.7 3386.4 3395.2 3430.4 61250.0 61580.7 62471.4 64319.7 64577.7 10679.7 10804.4 10821.6 10957.1 11026.1 20110.4 20111.0 20153.3 20277.3 20282.9 7247.2 7286.8 7306.5 7367.1 7545.6 3871.7 3957.9 4013.8 4023.4 4072.9 2998.2 3105.6 3116.3 3120.0 3123.6 525.8 555.4 559.8 568.3 569.2 534.2 562.2 570.3 646.5 647.7 7803.7 7945.4 8110.8 8132.9 8354.7 510.1 579.0 595.7 599.9 621.0 3681.9 3696.5 3784.4 3791.5 3853.2 57017.4 57065.7 57108.0 57170.0 88723.6 50278.5 61319.1 65749.0 76858.6 77387.6 71429.6 71637.0 72567.6 73631.3 74443.6 7524.8 7598.5 7620.8 7687.0 7777.4 43569.0 43616.6 43843.3 43964.6 44046.3 58228.1 61691.4 61750.4 62366.0 62589.4 8941.7 10327.5 10334.3 10454.3 10464.8 10819.8 10922.9 11143.1 11327.2 11346.8 9811.6 9952.3 10080.7 10441.1 10517.8 10085.8 10144.6 10153.9 10235.6 10340.9 9874.8 10067.3 10079.6 10526.3 10612.9 8903.6 8934.8 9068.4 9158.8 9475.1 8422.6 8538.1 8627.8 8647.0 8765.7 15:13:45 INFO - PROCESS | 26817 | -------- Summary: end -------- 15:13:45 INFO - PROCESS | 26817 | 15:13:46 INFO - TEST-INFO | 26817: exit 0 15:13:46 INFO - TEST-OK | dromaeo_css | took 1116960ms 15:13:46 INFO - TEST-START | kraken 15:13:46 INFO - operating with platform_type : linux_ 15:13:46 INFO - Initialising browser for kraken test... 15:13:46 INFO - TEST-INFO | started process 27052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz5XOJb/profile http://localhost:41468/getInfo.html) 15:13:51 INFO - PROCESS | 27052 | __metrics Screen width/height:1600/1200 15:13:51 INFO - PROCESS | 27052 | colorDepth:24 15:13:51 INFO - PROCESS | 27052 | Browser inner width/height: 1024/697 15:13:51 INFO - PROCESS | 27052 | __metrics 15:13:52 ERROR - PROCESS | 27052 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 15:13:53 INFO - TEST-INFO | 27052: exit 0 15:13:53 INFO - Browser initialized. 15:13:53 INFO - Running cycle 1/1 for kraken test... 15:13:53 INFO - TEST-INFO | started process 27169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz5XOJb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:14:05 INFO - PROCESS | 27169 | RSS: Main: 186200064 15:14:05 INFO - PROCESS | 27169 | 15:14:08 INFO - PROCESS | 27169 | Cycle 1(1): loaded http://localhost:41468/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41468/tests/kraken/driver.html?testName=audio-beat-detection) 15:14:09 INFO - PROCESS | 27169 | RSS: Main: 190312448 15:14:09 INFO - PROCESS | 27169 | 15:14:12 INFO - PROCESS | 27169 | Cycle 1(1): loaded http://localhost:41468/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41468/tests/kraken/driver.html?testName=audio-dft) 15:14:12 INFO - PROCESS | 27169 | RSS: Main: 190271488 15:14:12 INFO - PROCESS | 27169 | 15:14:15 INFO - PROCESS | 27169 | Cycle 1(1): loaded http://localhost:41468/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41468/tests/kraken/driver.html?testName=audio-fft) 15:14:16 INFO - PROCESS | 27169 | RSS: Main: 186073088 15:14:16 INFO - PROCESS | 27169 | 15:14:18 INFO - PROCESS | 27169 | Cycle 1(1): loaded http://localhost:41468/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41468/tests/kraken/driver.html?testName=audio-oscillator) 15:14:19 INFO - PROCESS | 27169 | RSS: Main: 186458112 15:14:19 INFO - PROCESS | 27169 | 15:14:21 INFO - PROCESS | 27169 | Cycle 1(1): loaded http://localhost:41468/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41468/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:14:22 INFO - PROCESS | 27169 | RSS: Main: 186908672 15:14:22 INFO - PROCESS | 27169 | 15:14:25 INFO - PROCESS | 27169 | Cycle 1(1): loaded http://localhost:41468/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41468/tests/kraken/driver.html?testName=imaging-darkroom) 15:14:26 INFO - PROCESS | 27169 | RSS: Main: 187830272 15:14:26 INFO - PROCESS | 27169 | 15:14:29 INFO - PROCESS | 27169 | Cycle 1(1): loaded http://localhost:41468/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41468/tests/kraken/driver.html?testName=imaging-desaturate) 15:14:30 INFO - PROCESS | 27169 | RSS: Main: 184393728 15:14:30 INFO - PROCESS | 27169 | 15:14:33 INFO - PROCESS | 27169 | Cycle 1(1): loaded http://localhost:41468/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41468/tests/kraken/driver.html?testName=json-parse-financial) 15:14:33 INFO - PROCESS | 27169 | RSS: Main: 185802752 15:14:33 INFO - PROCESS | 27169 | 15:14:35 INFO - PROCESS | 27169 | Cycle 1(1): loaded http://localhost:41468/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41468/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:14:36 INFO - PROCESS | 27169 | RSS: Main: 186163200 15:14:36 INFO - PROCESS | 27169 | 15:14:38 INFO - PROCESS | 27169 | Cycle 1(1): loaded http://localhost:41468/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41468/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:14:38 INFO - PROCESS | 27169 | RSS: Main: 186830848 15:14:38 INFO - PROCESS | 27169 | 15:14:41 INFO - PROCESS | 27169 | Cycle 1(1): loaded http://localhost:41468/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41468/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:14:41 INFO - PROCESS | 27169 | RSS: Main: 187285504 15:14:41 INFO - PROCESS | 27169 | 15:14:44 INFO - PROCESS | 27169 | Cycle 1(1): loaded http://localhost:41468/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41468/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:14:45 INFO - PROCESS | 27169 | RSS: Main: 187207680 15:14:45 INFO - PROCESS | 27169 | 15:14:48 INFO - PROCESS | 27169 | Cycle 1(1): loaded http://localhost:41468/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41468/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:14:48 INFO - PROCESS | 27169 | RSS: Main: 186650624 15:14:48 INFO - PROCESS | 27169 | 15:14:50 INFO - PROCESS | 27169 | Cycle 1(1): loaded http://localhost:41468/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41468/tests/kraken/driver.html?testName=ai-astar) 15:14:50 INFO - PROCESS | 27169 | RSS: Main: 187777024 15:14:50 INFO - PROCESS | 27169 | 15:14:50 INFO - PROCESS | 27169 | __start_tp_report 15:14:50 INFO - PROCESS | 27169 | _x_x_mozilla_page_load 15:14:50 INFO - PROCESS | 27169 | _x_x_mozilla_page_load_details 15:14:50 INFO - PROCESS | 27169 | |i|pagename|runs| 15:14:50 INFO - PROCESS | 27169 | |0;ai-astar;116;109;113;113;113;115;114;115;116;115 15:14:50 INFO - PROCESS | 27169 | |1;audio-beat-detection;163;136;167;191;144;162;163;135;199;134 15:14:50 INFO - PROCESS | 27169 | |2;audio-dft;165;167;179;163;164;164;164;164;163;162 15:14:50 INFO - PROCESS | 27169 | |3;audio-fft;76;76;76;171;76;76;76;77;159;77 15:14:50 INFO - PROCESS | 27169 | |4;audio-oscillator;86;87;149;86;89;86;138;91;86;135 15:14:50 INFO - PROCESS | 27169 | |5;imaging-gaussian-blur;119;118;118;118;118;118;119;119;118;124 15:14:50 INFO - PROCESS | 27169 | |6;imaging-darkroom;149;152;149;147;147;150;147;147;148;149 15:14:50 INFO - PROCESS | 27169 | |7;imaging-desaturate;96;96;95;96;97;97;96;95;96;96 15:14:50 INFO - PROCESS | 27169 | |8;json-parse-financial;64;64;64;64;64;64;64;64;64;64 15:14:50 INFO - PROCESS | 27169 | |9;json-stringify-tinderbox;66;66;66;67;66;65;65;67;65;66 15:14:50 INFO - PROCESS | 27169 | |10;stanford-crypto-aes;87;90;89;91;90;85;93;90;118;87 15:14:50 INFO - PROCESS | 27169 | |11;stanford-crypto-ccm;143;130;138;139;133;142;142;140;136;144 15:14:50 INFO - PROCESS | 27169 | |12;stanford-crypto-pbkdf2;169;173;169;171;173;176;167;171;168;165 15:14:50 INFO - PROCESS | 27169 | |13;stanford-crypto-sha256-iterative;69;69;68;70;68;67;69;66;68;68 15:14:50 INFO - PROCESS | 27169 | __end_tp_report 15:14:50 INFO - PROCESS | 27169 | __start_cc_report 15:14:50 INFO - PROCESS | 27169 | _x_x_mozilla_cycle_collect,999 15:14:50 INFO - PROCESS | 27169 | __end_cc_report 15:14:50 INFO - PROCESS | 27169 | __startTimestamp1465769690797__endTimestamp 15:14:50 INFO - PROCESS | 27169 | 15:14:50 INFO - PROCESS | 27169 | ------- Summary: start ------- 15:14:50 INFO - PROCESS | 27169 | Number of tests: 14 15:14:50 INFO - PROCESS | 27169 | 15:14:50 INFO - PROCESS | 27169 | [#0] ai-astar Cycles:10 Average:113.90 Median:115.00 stddev:2.08 (1.8%) stddev-sans-first:2.06 15:14:50 INFO - PROCESS | 27169 | Values: 116.0 109.0 113.0 113.0 113.0 115.0 114.0 115.0 116.0 115.0 15:14:50 INFO - PROCESS | 27169 | 15:14:50 INFO - PROCESS | 27169 | [#1] audio-beat-detection Cycles:10 Average:159.40 Median:163.00 stddev:22.81 (14.0%) stddev-sans-first:24.16 15:14:50 INFO - PROCESS | 27169 | Values: 163.0 136.0 167.0 191.0 144.0 162.0 163.0 135.0 199.0 134.0 15:14:50 INFO - PROCESS | 27169 | 15:14:50 INFO - PROCESS | 27169 | [#2] audio-dft Cycles:10 Average:165.50 Median:164.00 stddev:4.93 (3.0%) stddev-sans-first:5.22 15:14:50 INFO - PROCESS | 27169 | Values: 165.0 167.0 179.0 163.0 164.0 164.0 164.0 164.0 163.0 162.0 15:14:50 INFO - PROCESS | 27169 | 15:14:50 INFO - PROCESS | 27169 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:37.53 (49.4%) stddev-sans-first:39.24 15:14:50 INFO - PROCESS | 27169 | Values: 76.0 76.0 76.0 171.0 76.0 76.0 76.0 77.0 159.0 77.0 15:14:50 INFO - PROCESS | 27169 | 15:14:50 INFO - PROCESS | 27169 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:86.00 stddev:26.07 (30.3%) stddev-sans-first:26.89 15:14:50 INFO - PROCESS | 27169 | Values: 86.0 87.0 149.0 86.0 89.0 86.0 138.0 91.0 86.0 135.0 15:14:50 INFO - PROCESS | 27169 | 15:14:50 INFO - PROCESS | 27169 | [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:118.50 stddev:1.85 (1.6%) stddev-sans-first:1.96 15:14:50 INFO - PROCESS | 27169 | Values: 119.0 118.0 118.0 118.0 118.0 118.0 119.0 119.0 118.0 124.0 15:14:50 INFO - PROCESS | 27169 | 15:14:50 INFO - PROCESS | 27169 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:1.65 (1.1%) stddev-sans-first:1.74 15:14:50 INFO - PROCESS | 27169 | Values: 149.0 152.0 149.0 147.0 147.0 150.0 147.0 147.0 148.0 149.0 15:14:50 INFO - PROCESS | 27169 | 15:14:50 INFO - PROCESS | 27169 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 15:14:50 INFO - PROCESS | 27169 | Values: 96.0 96.0 95.0 96.0 97.0 97.0 96.0 95.0 96.0 96.0 15:14:50 INFO - PROCESS | 27169 | 15:14:50 INFO - PROCESS | 27169 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 15:14:50 INFO - PROCESS | 27169 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 15:14:50 INFO - PROCESS | 27169 | 15:14:50 INFO - PROCESS | 27169 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 15:14:50 INFO - PROCESS | 27169 | Values: 66.0 66.0 66.0 67.0 66.0 65.0 65.0 67.0 65.0 66.0 15:14:50 INFO - PROCESS | 27169 | 15:14:50 INFO - PROCESS | 27169 | [#10] stanford-crypto-aes Cycles:10 Average:92.00 Median:90.00 stddev:9.42 (10.5%) stddev-sans-first:9.81 15:14:50 INFO - PROCESS | 27169 | Values: 87.0 90.0 89.0 91.0 90.0 85.0 93.0 90.0 118.0 87.0 15:14:50 INFO - PROCESS | 27169 | 15:14:50 INFO - PROCESS | 27169 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:141.00 stddev:4.55 (3.2%) stddev-sans-first:4.55 15:14:50 INFO - PROCESS | 27169 | Values: 143.0 130.0 138.0 139.0 133.0 142.0 142.0 140.0 136.0 144.0 15:14:50 INFO - PROCESS | 27169 | 15:14:50 INFO - PROCESS | 27169 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:171.00 stddev:3.26 (1.9%) stddev-sans-first:3.43 15:14:50 INFO - PROCESS | 27169 | Values: 169.0 173.0 169.0 171.0 173.0 176.0 167.0 171.0 168.0 165.0 15:14:50 INFO - PROCESS | 27169 | 15:14:50 INFO - PROCESS | 27169 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:1.14 (1.7%) stddev-sans-first:1.17 15:14:50 INFO - PROCESS | 27169 | Values: 69.0 69.0 68.0 70.0 68.0 67.0 69.0 66.0 68.0 68.0 15:14:50 INFO - PROCESS | 27169 | -------- Summary: end -------- 15:14:50 INFO - PROCESS | 27169 | 15:14:51 INFO - TEST-INFO | 27169: exit 0 15:14:51 INFO - TEST-OK | kraken | took 65316ms 15:14:51 INFO - SUITE-END | took 1182s 15:14:51 INFO - Completed test suite (00:19:42) 15:14:51 INFO - javascript benchmark 15:14:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6290.200425413057, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.217234829551, 2663.9067632632855, 2666.3067602423366, 2674.531956907542, 2690.973090269098, 4775.928361074582, 4782.0, 4783.712977221365, 4811.061842940628, 4815.590674792638, 4626.421697287839, 4761.69049011814, 4784.258439941806, 4800.783964721587, 4849.830255941043, 4340.891477713051, 4421.6683748718815, 4464.843730469434, 4476.306172543244, 4513.909721805562, 576.1000441090567, 4317.13657268546, 4318.352247162919, 4350.042990542076, 4410.603045725884, 4354.477462704464, 4390.165868484977, 4396.032872767986, 4398.406215160944, 4450.421445212134, 4388.561143885618, 4398.582134697199, 4429.446319210098, 4432.977835110836, 4435.068635586531, 4312.870613881589, 4352.7823608819435, 4361.214981303364, 4366.759828209447, 4376.081022985177, 4760.738159401231, 4798.928016079762, 4801.447833499123, 4803.327534145223, 4809.591184749301, 4985.0, 5090.160123579605, 5151.871203219949, 5163.32876726027, 5193.065248255312, 5118.053160165344, 5171.715555644438, 5174.068667639824, 5175.792968281265, 5180.948190518122, 4851.417829860439, 4853.757312134415, 4854.271859221145, 4859.198232291703, 4911.042346742387, 5284.128118860422, 5294.655847369986, 5313.495217954288, 5331.0, 5353.839384818461, 5074.517920797518, 5077.517635824591, 5086.033653605803, 5087.0, 5088.389393272831, 5178.61160412963, 5190.896182076337, 5193.195054766442, 5194.454582268883, 5202.2456743771945, 4918.680285781413, 5118.923216151761, 5149.098907691139, 5170.6122040847085, 5180.326557547494, 5123.87190320245, 5153.3558305211845, 5154.046501397253, 5158.767855446514, 5181.663191892515, 4194.035371864488, 4321.070969741458, 4323.135372925428, 4324.610785029363, 4368.475782906072, 3694.649008344203, 3752.1932784451474, 3773.132179598653, 3788.052986753312, 3806.1436176859984, 4435.423394958635, 4441.089576636782, 4445.73325600465, 4473.306637471197, 4514.954850451519, 5085.4914508548845, 5096.541311282002, 5098.821541246039, 5130.7947682093045, 5132.974335128375, 4351.760653164107, 4454.977725111354, 4507.233770259064, 4520.2315606347, 4523.819047238074, 4588.564086411786, 4614.123316569841, 4620.283856002325, 4644.164050470948, 4666.813327466931, 4763.857084287477, 4876.439209490883, 4914.5822605078965, 4925.852224433273, 4967.155583550877, 5160.638755287244, 5179.19722443022, 5214.191800270964, 5219.739013049409, 5220.3213582235585, 4811.951880481291, 4884.8046078157895, 4915.631327650369, 4934.654574179916, 4970.577500912318, 5093.134167191661, 5107.029664363759, 5144.125498665311, 5149.330587023663, 5149.845504634867, 5190.273361729436, 5233.241180028951, 5233.973830130825, 5236.109861323508, 5274.077036518671, 5073.264376665436, 5085.491450855033, 5092.3125378074965, 5105.489451054865, 5113.028524580318, 4871.269309603588, 4989.700617962933, 5028.899422011466, 5037.7733002014265, 5061.367329083864, 4978.4025916890205, 4987.725675087905, 5005.1241032819835, 5014.197728363444, 5055.797768089235, 5056.317397151338, 5105.081085404663, 5108.055009823194, 5109.3613298337705, 5118.181091025418, 4859.028194361213, 4917.237828136645, 4972.2790195422185, 4994.2508623706735, 5004.249362595494], "value": 4702.529790395987, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.7290060172738, 582.8688545077358, 590.2592246730353, 608.2427377914496, 612.5773216480625, 37631.43552846706, 38712.22575548488, 41483.377749333784, 41491.0, 41515.377269340985, 41444.37833432493, 41583.0, 41652.37521437181, 41815.79092104535, 42077.0, 7741.264579864904, 7880.842383152333, 7881.60591970402, 7936.404769642271, 7938.16649251826, 7779.7666070017995, 7796.76609701707, 7811.101723301807, 7914.643841027168, 7916.485428447161, 7828.334591559725, 7898.526088434713, 7915.366770658334, 7919.24767147123, 7920.722774702886, 7882.290593846553, 7901.525908445512, 7903.604819758989, 7936.841263174733, 7950.363970882316, 7819.2180781921925, 7861.606919653995, 7881.054273487218, 7886.171951945078, 7936.246056624669, 39131.0, 39204.60795392067, 39213.41179882304, 39408.21183576341, 39609.40585891214, 2515.7861581765574, 2901.1586639874413, 2968.257935516121, 3386.2211691311136, 3672.816359182057, 27979.580306295422, 28237.717622823715, 28904.132876013755, 28924.0, 29402.852985734935, 3317.9170520736934, 3406.199543107368, 3415.9316813663586, 3422.401079811023, 3472.166679996808, 219348.0, 221036.0, 221338.0, 222180.0, 222617.0, 32560.511592326133, 32755.836220818743, 32978.3404331912, 32981.50527742086, 33039.3392132156, 33571.16072098168, 34818.82590587031, 35170.12074698153, 35198.0, 35345.116372090386, 13514.39185236647, 13659.0, 13795.793063104062, 13821.308934553232, 13832.654183645489, 10254.333468324536, 10314.742131446774, 10317.123044541147, 10345.741356465998, 10348.327358721659, 7954.482958607672, 7970.40221983342, 7992.320652744465, 8074.919250807534, 8115.147909469539, 3089.258577941278, 3125.9218519537194, 3176.0, 3178.1577881861326, 3193.3294008258526, 853.117023880281, 872.7556284240422, 892.8839250897472, 894.4007514964859, 914.8307563100848, 28199.43601128007, 28541.429171416872, 28623.14130576086, 28673.56989645157, 28890.42219155647, 922.801597656507, 948.7390967483859, 959.788846453793, 961.4567769210514, 984.7488890332919, 14432.927835360755, 15112.168830714416, 15155.696886062438, 15309.693806123814, 15475.922620387051, 121405.0, 123256.0, 125100.0, 369083.0, 369905.0, 49873.50126498761, 50652.49347506478, 50746.746266268434, 50789.49210507922, 50906.74546627317, 1133.3369978562632, 1149.373591392693, 1153.296489141623, 1161.7444162284285, 1162.4943149729895, 26851.32871678224, 27439.176824695292, 27982.160535183975, 28595.571066434437, 28669.426611468072, 44391.77804110959, 44429.33355999598, 44508.332375015045, 44689.32966005577, 44705.0, 331078.0, 332230.0, 333110.0, 333547.3322633468, 333941.0, 25778.613320800578, 25796.226113216635, 26125.477490450463, 26278.605820913082, 26869.0, 42218.0, 42579.0, 43122.353164701926, 43339.0, 43620.0, 36696.26607467889, 36826.8158659205, 36890.8155459221, 37059.81470092632, 37254.0, 36302.45546316754, 36670.633293667786, 36741.816290918374, 36748.63251367452, 37353.0661733448, 32542.51186232161, 37342.626573735004, 37352.62647373491, 37464.0, 38446.423303649906, 31939.201519962186, 32972.1756956078, 33114.834425827714, 33400.49899251562, 33416.33167336688, 25637.48725025452, 26229.868850655625, 26290.605640915783, 26311.342216444744, 26439.33901652474], "value": 16139.229864198185, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.218341482886, 375.2850819189444, 387.08068337697966, 398.1678292368948, 404.5287240364973, 15194.623103291695, 16605.33578656854, 16735.0, 16831.83168168318, 17005.404810831624, 16173.0, 16278.883745113148, 17035.744463833053, 17102.0, 17116.914415427906, 3426.0920855973063, 4536.4329458817565, 4765.380500534926, 4771.212749896263, 4790.664653474259, 5286.920696189561, 5625.156226566007, 5627.465390787868, 5629.4652008059165, 5644.6613203207735, 5469.15228139639, 5570.053090974544, 5588.776448942038, 5609.158626206061, 6057.242844644419, 5895.823125306248, 5965.194698715662, 6054.212952316215, 6058.727357268934, 6068.6965651717455, 4741.2651039089, 5091.61812864033, 5101.7194054327, 5245.554127899133, 5288.603354748409, 12484.250944943242, 12566.434510447052, 12654.620361389174, 12795.296258705768, 18550.0, 1909.3648378531584, 1938.6413513499906, 1984.0377416952767, 1997.510609900569, 2058.835293176542, 8825.514596697243, 9167.954160229156, 9339.673111441067, 9636.614535418576, 9716.465594392306, 1644.128611835717, 1665.3338664534162, 1729.5519114788392, 1773.9379121730678, 1853.7034074548142, 47552.524474755155, 66334.33665663378, 66343.66828165877, 66714.66642666805, 67251.327486725, 10116.190704743603, 10333.276670633133, 10372.170226381872, 10837.024667779937, 11094.389808560607, 14250.786238206436, 14271.714565708628, 14272.0, 14286.357113929898, 14365.425382984564, 7377.926220737724, 7478.663460144307, 7636.08366995964, 7706.691732330756, 7724.6523906424345, 7181.569105853561, 7276.272372762682, 7392.96303518479, 7402.407807375397, 7488.737894173787, 3937.1338305572726, 4344.717593356421, 4402.757848318309, 4466.687331886802, 4482.46210454741, 1734.7137722275936, 1785.4554360919785, 1816.8455681266976, 1820.7815062192622, 1849.842763365129, 795.3478147918767, 844.7127976488024, 877.3376101043672, 917.0554329041098, 937.5921474158627, 15983.28075236594, 16168.595785105466, 16449.848510604144, 16510.17449127539, 16746.74879876803, 826.7643721539332, 834.4325858416214, 837.4891316297054, 840.4369072721291, 840.7309660908451, 8340.791480213044, 9207.40151890125, 9276.536173191313, 9339.486328252011, 9361.4383137012, 381455.0, 390896.0, 395013.0, 405052.0, 407894.0, 75666.0, 78358.21641783623, 78428.0, 80549.19450805534, 81285.59357203176, 861.4271509446148, 912.7991841794794, 917.9495127767904, 930.2418528898926, 934.4860326820221, 15263.923680381971, 15333.233338333263, 15378.461753838563, 15387.923060384626, 15679.686406271583, 34163.0, 35305.47041794324, 35559.81549152385, 36346.8182659085, 36645.450318244715, 47480.0, 51198.0, 51766.223506646675, 52923.20615190698, 54303.72848135892, 7818.921810782047, 7936.920630793618, 8030.317423018875, 8044.4771089881315, 8087.069986951576, 11502.654920352403, 11962.222455540363, 12134.393280336124, 12193.69515762113, 12591.748165036832, 9765.658201962897, 10339.431331276852, 10423.166146708094, 10441.112505437122, 10446.52990615409, 10392.272540922062, 10569.894301056891, 10584.523696433525, 10621.309614875008, 10796.352218866894, 10728.409937453203, 10796.89203107959, 10809.0812280957, 10860.348379097279, 10961.177911656498, 6766.15423072116, 7845.9607701963405, 7893.881591776013, 7959.880601791094, 7989.400794940519, 7814.374850012099, 9304.627814887328, 9361.719148425558, 9393.624255029723, 9642.325037247325], "value": 8132.717891547487, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.166638350606, 1395.0374241773175, 1461.04301682398, 1644.3833562414102, 1645.1774112943529, 6871.828204294895, 7421.0, 7505.324520793128, 8012.038555373356, 8073.192680731924, 7392.815179620498, 7563.168051514343, 7642.0, 7712.845743085149, 7714.190010048948, 2211.458192742776, 2263.0155882191216, 2264.071730590458, 2264.6036943534896, 2271.1483193802324, 2184.202765990418, 2221.522372689871, 2248.213125406103, 2248.9437764055947, 2257.2551058150852, 2245.438640339915, 2251.997860951877, 2258.119333459952, 2261.1294651559188, 2263.3323169664905, 2198.2416066457045, 2208.723909511303, 2213.1258153029544, 2223.144089525528, 2230.0745190745984, 2164.891755412223, 2188.518525924294, 2188.5513469738667, 2189.6606026065983, 2192.0574153114153, 7738.496997695188, 7764.223577642247, 7766.10689770678, 7775.222477752236, 7785.610719464004, 4670.0, 4787.760611969387, 4800.735959522225, 4812.590929770974, 4828.0585285869265, 2683.2755156107937, 3025.9394812103633, 3028.2732144285433, 3034.605501284841, 3042.5284080967485, 891.741394995457, 918.2011649864594, 931.78568929146, 940.8965013848472, 946.2193690205607, 10636.0, 10897.618583349624, 10900.781984360348, 10935.945320273428, 10951.123910087173, 4235.4917409911, 4306.590873866978, 4392.560743925582, 4415.977920110443, 4423.756693381895, 9231.538423078819, 9357.39176953496, 9385.812283754423, 9392.107749763762, 9399.342046056847, 4737.242041273448, 4798.904021919542, 4827.25177597473, 4848.0788650156355, 4866.6350023747655, 3744.02655309616, 4168.687348448879, 4294.506131794884, 4354.455693038371, 4438.245498265303, 3770.2271034437877, 3816.809159542012, 3873.0704630888386, 3902.048975512244, 3977.8607748728655, 1222.6882145052955, 1258.3205069262497, 1272.9299888506036, 1282.7434513097419, 1284.7687416265162, 666.3403230801568, 801.2988634944423, 816.1104396208043, 836.5775283481925, 846.8602680557639, 5114.28400023997, 5161.74191290434, 5285.392179899361, 5323.733813309319, 5368.4631536846, 406.46143859386433, 410.61197168675915, 412.6863583676367, 415.2815628961913, 416.50227977567124, 3437.470420317977, 3524.875162749886, 3566.5006899034156, 3569.8929032129076, 3588.102974256436, 9549.9045009549, 9887.258455615858, 9918.752031199278, 9925.30522863407, 9935.701928942144, 9749.610015599297, 9833.901660983442, 9838.950805245928, 9845.212383009342, 9858.507074646239, 7402.851942961111, 7472.505498900242, 7496.25037496246, 7497.10034795828, 7500.099988001475, 5184.351956005499, 5319.175527793198, 5339.492748188916, 5412.972935135456, 5451.836444906659, 8920.687775927812, 8932.776680583038, 8980.955095224483, 9200.585973631336, 9227.077292270988, 9020.278377729897, 9137.680181193626, 9148.359614826899, 9178.495182765013, 9183.403078799856, 6060.787872424444, 6409.102725618324, 6601.0, 6845.520813543004, 6869.896951545631, 7519.812004699927, 7600.315971562365, 7632.045994250719, 7636.770896873103, 7714.729984450517, 6799.3200679931615, 7011.3339232772805, 7061.611611361219, 7141.500094993301, 7148.785536433916, 6887.104676392037, 6890.345417185359, 6910.654467276717, 7001.684924178322, 7007.229204787572, 5757.481826635623, 5940.584159108821, 5992.610480318765, 6314.463270622048, 6383.106365108795, 4419.712718673276, 4479.776011199362, 4518.322251662145, 4614.192516309699, 4714.717116972993, 4570.428696412949, 4593.494715581351, 4625.560571745679, 4650.9767451162525, 4692.9530704692515], "value": 4113.042475871556, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.4061717182807, 306.75153125967967, 308.19868342309996, 311.2328111205877, 312.4111050669489, 4847.49101344359, 4876.171050921343, 5078.365204349457, 5114.284000239964, 5117.130087885059, 4917.803287868481, 4929.507049295069, 4964.751762411883, 4969.105560999019, 4970.577500912418, 3937.684985201177, 3945.8618948336816, 3957.1887763008513, 3965.9405108923247, 3982.0443093657605, 3712.164762928333, 3965.4051892216253, 3971.0, 4002.939955900664, 4003.519577650686, 3856.633619806114, 3872.1287710265105, 3886.145048089416, 3891.7081218908697, 3894.0, 3853.2678791029894, 3855.63371479709, 3864.6908247340425, 3865.246276975991, 3899.688024958011, 3262.054004338739, 3377.5946886373545, 3379.104537297618, 3392.898213053588, 3393.151712071982, 4866.732329721864, 4872.3909511311085, 4877.780499877514, 4897.681650692729, 4906.828261010847, 4434.733915965053, 4460.643148548108, 4464.6874718769695, 4481.619062379702, 4520.09598080382, 5042.167952356236, 5215.217717342429, 5238.580913526908, 5274.446183150791, 5279.128943724281, 3746.463949780577, 3760.849566017356, 3770.5286839145106, 3773.4528493368307, 3782.111203867089, 5500.779968801243, 5545.611807173499, 5562.972185139089, 5565.471280228372, 5579.246801681802, 3764.981175094107, 3835.5589107252463, 3855.151866589346, 3871.0, 3886.417037444406, 3822.7384962962155, 3835.865744698978, 3841.673457756122, 3844.9231015379537, 3845.1732877431486, 4368.08270263242, 4369.427006277738, 4390.1878152541885, 4400.581944715311, 4404.955950440454, 5152.299741085433, 5212.7914883405, 5224.2947202127225, 5250.606204534599, 5260.28986086881, 1185.6206014075412, 1316.2694704439127, 1335.6927906581345, 1341.7920222365549, 1343.43575698207, 828.0725587342095, 828.9419740618099, 847.8643417053365, 853.1681610429781, 857.1728282207699, 4147.502299724052, 4180.038591124058, 4197.433346498245, 4214.346776249687, 4236.703430759817, 4729.834455794031, 4779.880502987384, 4858.319835223072, 4859.441164266084, 4875.0, 4097.508299004138, 4145.66834653227, 4154.480689913761, 4158.542560318362, 4163.791810409467, 2443.547943630434, 2595.260350800013, 2612.542805009116, 2627.356297707074, 2633.9464214314044, 4516.0, 4547.613452856544, 4558.2251017327135, 4565.840195593139, 4568.588827005586, 4858.708477491362, 4870.9269360959615, 4874.268859671078, 4896.804127834918, 4938.555530002245, 4430.224710675619, 4455.819207909906, 4599.4710608280475, 4620.653450991189, 4631.305304204397, 4762.618990480684, 4769.2130798417875, 4797.4482934461585, 4798.47216806144, 4847.587955023862, 4683.508231635629, 4708.270218116198, 4714.292856071616, 4727.834525791581, 4741.288806678887, 4607.516210797952, 4690.1792186366565, 5157.426984769681, 5187.507186817246, 5237.0, 3808.2383523296007, 3827.158025234444, 3827.827747751302, 3834.8274327654763, 3843.2121415110396, 5237.214417837355, 5524.922640085145, 5529.889402212014, 5530.198121272473, 5559.610827242054, 5190.922136168036, 5292.682439053669, 5295.947040529545, 5302.655327403706, 5304.257403963526, 5286.62993590445, 5287.863109431491, 5296.973515132399, 5319.281896943863, 5330.8933821324135, 4935.605151587936, 5188.662736922088, 5209.635325527177, 5212.530872221519, 5245.239440281214, 5217.269582258563, 5288.762005709676, 5300.310959575385, 5318.787248510016, 5372.045375043788, 5240.868978275574, 5243.8164664236565, 5247.379308277276, 5252.608058864327, 5266.0], "value": 3841.3230987663815, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.2408661433052, 649.8732747114309, 668.2982867988611, 728.4281838756575, 738.7746737245142, 12508.186967847096, 13574.728505429897, 13591.79612305815, 13603.251821149834, 13607.319634018284, 12176.634700958963, 12342.81485777714, 12460.252384856914, 12784.42470088846, 12822.230666160038, 622.3900577434117, 768.7155752371602, 770.9421793365492, 779.3726050529322, 782.9491083079581, 768.7271018788333, 768.8731359325733, 769.1347234361343, 774.8256642255503, 778.6846327237449, 833.7998880268722, 836.1972506393869, 837.6314421654483, 838.0990435282066, 842.3050982939069, 828.204923273658, 832.9125441828642, 833.0752864320599, 834.5410024486539, 838.9035260944978, 600.2287061126475, 608.3186830749589, 608.7838817219912, 609.2171559546007, 609.7926704920349, 13499.460021599125, 13634.727305453835, 13640.317984100855, 13657.590272291747, 13679.521216757366, 13350.0, 13535.0, 13549.187048777007, 13794.0, 13960.232187229698, 10450.24736674109, 10640.627578034731, 10643.57425702971, 10710.41092739899, 10792.51433685486, 3332.500124981272, 3382.6617338266224, 3386.4243078676686, 3395.151212196951, 3430.382531144393, 61250.0, 61580.69209653923, 62471.375286247014, 64319.67840160769, 64577.67711161414, 10679.679609611723, 10804.405757683402, 10821.621243256448, 10957.06864916475, 11026.062784663232, 20110.39668809938, 20111.0, 20153.294634687714, 20277.29029483961, 20282.89858550727, 7247.23903990084, 7286.817829554304, 7306.525075870051, 7367.079115110611, 7545.584992825447, 3871.6515513603913, 3957.920841583152, 4013.8394464221687, 4023.4166045923175, 4072.857449989236, 2998.205475548981, 3105.6428510721103, 3116.25209949615, 3119.9704097647723, 3123.6095488063993, 525.8343621759134, 555.4334578729673, 559.8096647139911, 568.2669356530113, 569.1775384569257, 534.180033648348, 562.2493970549363, 570.2729020498897, 646.4860435953428, 647.6729251727942, 7803.726869559651, 7945.364370850318, 8110.756677299691, 8132.878006829902, 8354.665813367397, 510.08185266520115, 578.9739461724232, 595.7378753348513, 599.9392088177126, 620.9720562574695, 3681.9263614727556, 3696.537932758405, 3784.3566593679143, 3791.450239715226, 3853.1715681128694, 57017.42982570121, 57065.71467142721, 57108.0, 57170.0, 88723.55638221768, 50278.49721502811, 61319.08021379683, 65749.0, 76858.6157069211, 77387.61306193433, 71429.64285178541, 71637.0, 72567.63716181491, 73631.26368736244, 74443.62778186075, 7524.774256772305, 7598.468107232441, 7620.783593053569, 7687.0, 7777.3778097753175, 43569.0, 43616.56383436125, 43843.342349865416, 43964.560354396046, 44046.33930490981, 58228.12657810221, 61691.383086168564, 61750.38249617446, 62366.0, 62589.37410625836, 8941.731748047569, 10327.535260913126, 10334.328268662513, 10454.268201225841, 10464.843027354444, 10819.783604328028, 10922.945385273022, 11143.108551315712, 11327.207095503565, 11346.829797552879, 9811.607535698493, 9952.25358098131, 10080.747981300527, 10441.060304572626, 10517.789644207227, 10085.848712269175, 10144.594216231268, 10153.949230253802, 10235.641752538922, 10340.948295258475, 9874.802503950024, 10067.29528932997, 10079.596816127567, 10526.315789473965, 10612.893871061191, 8903.554822258991, 8934.776630584287, 9068.365214434927, 9158.771030724285, 9475.099865512766, 8422.634150224381, 8538.13223402548, 8627.784305392415, 8647.0, 8765.737027889174], "value": 6351.077004388388, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1598.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 113.0, 113.0, 113.0, 115.0, 114.0, 115.0, 116.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 136.0, 167.0, 191.0, 144.0, 162.0, 163.0, 135.0, 199.0, 134.0], "value": 159.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 179.0, 163.0, 164.0, 164.0, 164.0, 164.0, 163.0, 162.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 171.0, 76.0, 76.0, 76.0, 77.0, 159.0, 77.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 149.0, 86.0, 89.0, 86.0, 138.0, 91.0, 86.0, 135.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 119.0, 118.0, 124.0], "value": 118.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 152.0, 149.0, 147.0, 147.0, 150.0, 147.0, 147.0, 148.0, 149.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 97.0, 97.0, 96.0, 95.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 66.0, 65.0, 65.0, 67.0, 65.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 89.0, 91.0, 90.0, 85.0, 93.0, 90.0, 118.0, 87.0], "value": 92.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 130.0, 138.0, 139.0, 133.0, 142.0, 142.0, 140.0, 136.0, 144.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 173.0, 169.0, 171.0, 173.0, 176.0, 167.0, 171.0, 168.0, 165.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 70.0, 68.0, 67.0, 69.0, 66.0, 68.0, 68.0], "value": 68.2, "unit": "score"}]}]} 15:14:52 INFO - Return code: 0 15:14:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:14:52 ERROR - # TBPL SUCCESS # 15:14:52 INFO - Running post-action listener: _resource_record_post_action 15:14:52 INFO - ##### 15:14:52 INFO - ##### Finished run-tests step (success) 15:14:52 INFO - ##### 15:14:52 INFO - Running post-run listener: _resource_record_post_run 15:14:52 INFO - Total resource usage - Wall time: 1199s; CPU: 14.0%; Read bytes: 4096; Write bytes: 538996736; Read time: 20; Write time: 1117188 15:14:52 INFO - TinderboxPrint: CPU usage
13.6% 15:14:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 15:14:52 INFO - TinderboxPrint: I/O write bytes / time
538,996,736 / 1,117,188 15:14:52 INFO - TinderboxPrint: CPU idle
8,264.8 (86.4%) 15:14:52 INFO - TinderboxPrint: CPU user
1,235.1 (12.9%) 15:14:52 INFO - TinderboxPrint: Swap in / out
0 / 0 15:14:52 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 244256768; Read time: 0; Write time: 727924 15:14:52 INFO - run-tests - Wall time: 1184s; CPU: 14.0%; Read bytes: 4096; Write bytes: 294739968; Read time: 20; Write time: 389264 15:14:52 INFO - Running post-run listener: _upload_blobber_files 15:14:52 INFO - Blob upload gear active. 15:14:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:14:52 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 15:14:52 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:14:52 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:14:53 INFO - (blobuploader) - INFO - Open directory for files ... 15:14:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:14:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:14:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:56 INFO - (blobuploader) - INFO - Done attempting. 15:14:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:14:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:14:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:57 INFO - (blobuploader) - INFO - Done attempting. 15:14:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:14:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:14:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:58 INFO - (blobuploader) - INFO - Done attempting. 15:14:58 INFO - (blobuploader) - INFO - Iteration through files over. 15:14:58 INFO - Return code: 0 15:14:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:14:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:14:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dfabc6ddcd5c017b66bd271850019a117347829d265693917d6e599885d0905815d424763a7c67b8a98d01a2dca9764b9524dc26b3e1c931ace17100e7cbaf2d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55894f48564602293257184c14fdb805cef37dbc2f4898f3bf9b528cd7b8d40bb910661e2cd41cc4fea158e466a74b5a7c45591d59f46287c1d60d13010a33b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05d1a12185b0095b8eaeeeffa09626d8bd84d57f0bc9117516e21d6c7587d542655d13414a8a596ae56b8c9c067df837ed4daf6e16d20091195cd8f575c3fe78"} 15:14:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:14:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:14:58 INFO - Contents: 15:14:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dfabc6ddcd5c017b66bd271850019a117347829d265693917d6e599885d0905815d424763a7c67b8a98d01a2dca9764b9524dc26b3e1c931ace17100e7cbaf2d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55894f48564602293257184c14fdb805cef37dbc2f4898f3bf9b528cd7b8d40bb910661e2cd41cc4fea158e466a74b5a7c45591d59f46287c1d60d13010a33b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05d1a12185b0095b8eaeeeffa09626d8bd84d57f0bc9117516e21d6c7587d542655d13414a8a596ae56b8c9c067df837ed4daf6e16d20091195cd8f575c3fe78"} 15:14:58 INFO - Running post-run listener: copy_logs_to_upload_dir 15:14:58 INFO - Copying logs to upload dir... 15:14:58 INFO - mkdir: /builds/slave/test/build/upload/logs 15:14:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.176410 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-12 15:14:57.671930) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-12 15:14:57.675948) ========= 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=af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dfabc6ddcd5c017b66bd271850019a117347829d265693917d6e599885d0905815d424763a7c67b8a98d01a2dca9764b9524dc26b3e1c931ace17100e7cbaf2d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55894f48564602293257184c14fdb805cef37dbc2f4898f3bf9b528cd7b8d40bb910661e2cd41cc4fea158e466a74b5a7c45591d59f46287c1d60d13010a33b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05d1a12185b0095b8eaeeeffa09626d8bd84d57f0bc9117516e21d6c7587d542655d13414a8a596ae56b8c9c067df837ed4daf6e16d20091195cd8f575c3fe78"} build_url:https://queue.taskcluster.net/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/GBUqyHvMTbmnPsfg1rDUxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dfabc6ddcd5c017b66bd271850019a117347829d265693917d6e599885d0905815d424763a7c67b8a98d01a2dca9764b9524dc26b3e1c931ace17100e7cbaf2d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55894f48564602293257184c14fdb805cef37dbc2f4898f3bf9b528cd7b8d40bb910661e2cd41cc4fea158e466a74b5a7c45591d59f46287c1d60d13010a33b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05d1a12185b0095b8eaeeeffa09626d8bd84d57f0bc9117516e21d6c7587d542655d13414a8a596ae56b8c9c067df837ed4daf6e16d20091195cd8f575c3fe78"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-12 15:14:57.701003) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 15:14:57.701328) ========= 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=af724c981e2a0f424dbabf99000001e7-1465768451.711691-1698068085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 15:14:57.790477) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-12 15:14:57.790821) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-12 15:14:57.791128) ========= ========= Total master_lag: 0.17 =========