builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1466764575.13 results: success (0) buildid: 20160624021502 builduid: 2e833c72622a4cc3a482dcaf2a274cb8 revision: 939ecc4e9d055c263633cbe276bfb634a68fe4c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 03:36:15.131851) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 03:36:15.132411) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 03:36:15.132730) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 03:36:15.148692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:36:15.149003) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 03:36:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.0M=0s 2016-06-24 03:36:15 (70.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118656 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:36:15.282108) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:36:15.282492) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014617 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:36:15.332581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 03:36:15.333015) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 939ecc4e9d055c263633cbe276bfb634a68fe4c5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 939ecc4e9d055c263633cbe276bfb634a68fe4c5 --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=652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 03:36:15,991 truncating revision to first 12 chars 2016-06-24 03:36:15,991 Setting DEBUG logging. 2016-06-24 03:36:15,991 attempt 1/10 2016-06-24 03:36:15,991 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/939ecc4e9d05?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 03:36:17,302 unpacking tar archive at: mozilla-central-939ecc4e9d05/testing/mozharness/ program finished with exit code 0 elapsedTime=1.642142 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 03:36:16.992777) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 03:36:16.993476) ========= script_repo_revision: 939ecc4e9d055c263633cbe276bfb634a68fe4c5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 03:36:16.994359) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 03:36:16.994949) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 03:36:17.006830) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-24 03:36:17.007177) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:36:17 INFO - MultiFileLogger online at 20160624 03:36:17 in /builds/slave/test 03:36:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:36:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:36:17 INFO - {'append_to_log': False, 03:36:17 INFO - 'base_work_dir': '/builds/slave/test', 03:36:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:36:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:36:17 INFO - 'branch': 'Firefox-Non-PGO', 03:36:17 INFO - 'buildbot_json_path': 'buildprops.json', 03:36:17 INFO - 'config_files': ('talos/linux_config.py',), 03:36:17 INFO - 'default_actions': ('clobber', 03:36:17 INFO - 'read-buildbot-config', 03:36:17 INFO - 'download-and-extract', 03:36:17 INFO - 'populate-webroot', 03:36:17 INFO - 'create-virtualenv', 03:36:17 INFO - 'install', 03:36:17 INFO - 'run-tests'), 03:36:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:36:17 INFO - 'download_minidump_stackwalk': True, 03:36:17 INFO - 'download_symbols': 'ondemand', 03:36:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:36:17 INFO - 'tooltool.py': '/tools/tooltool.py', 03:36:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:36:17 INFO - '/tools/misc-python/virtualenv.py')}, 03:36:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:36:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:36:17 INFO - 'installer_path': 'installer.exe', 03:36:17 INFO - 'log_level': 'info', 03:36:17 INFO - 'log_name': 'talos', 03:36:17 INFO - 'log_to_console': True, 03:36:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:36:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:36:17 INFO - 'opt_config_files': (), 03:36:17 INFO - 'pip_index': False, 03:36:17 INFO - 'sps_profile': False, 03:36:17 INFO - 'sps_profile_interval': 0, 03:36:17 INFO - 'suite': 'dromaeojs', 03:36:17 INFO - 'system_bits': '32', 03:36:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:36:17 INFO - 'title': 'talos-linux64-ix-046', 03:36:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:36:17 INFO - 'use_talos_json': True, 03:36:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:36:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:36:17 INFO - 'work_dir': 'build'} 03:36:17 INFO - ##### 03:36:17 INFO - ##### Running clobber step. 03:36:17 INFO - ##### 03:36:17 INFO - Running pre-action listener: _resource_record_pre_action 03:36:17 INFO - Running main action method: clobber 03:36:17 INFO - rmtree: /builds/slave/test/build 03:36:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:36:18 INFO - Running post-action listener: _resource_record_post_action 03:36:18 INFO - ##### 03:36:18 INFO - ##### Finished clobber step (success) 03:36:18 INFO - ##### 03:36:18 INFO - ##### 03:36:18 INFO - ##### Running read-buildbot-config step. 03:36:18 INFO - ##### 03:36:18 INFO - Running pre-action listener: _resource_record_pre_action 03:36:18 INFO - Running main action method: read_buildbot_config 03:36:18 INFO - Using buildbot properties: 03:36:18 INFO - { 03:36:18 INFO - "project": "", 03:36:18 INFO - "product": "firefox", 03:36:18 INFO - "script_repo_revision": "production", 03:36:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:36:18 INFO - "repository": "", 03:36:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:36:18 INFO - "buildid": "20160624021502", 03:36:18 INFO - "pgo_build": "False", 03:36:18 INFO - "basedir": "/builds/slave/test", 03:36:18 INFO - "buildnumber": 619, 03:36:18 INFO - "slavename": "talos-linux64-ix-046", 03:36:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:36:18 INFO - "platform": "ubuntu64_hw", 03:36:18 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:36:18 INFO - "branch": "mozilla-central", 03:36:18 INFO - "repo_path": "mozilla-central", 03:36:18 INFO - "revision": "939ecc4e9d055c263633cbe276bfb634a68fe4c5", 03:36:18 INFO - "stage_platform": "linux64", 03:36:18 INFO - "builduid": "2e833c72622a4cc3a482dcaf2a274cb8", 03:36:18 INFO - "slavebuilddir": "test" 03:36:18 INFO - } 03:36:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:36:18 INFO - Running post-action listener: _resource_record_post_action 03:36:18 INFO - ##### 03:36:18 INFO - ##### Finished read-buildbot-config step (success) 03:36:18 INFO - ##### 03:36:18 INFO - ##### 03:36:18 INFO - ##### Running download-and-extract step. 03:36:18 INFO - ##### 03:36:18 INFO - Running pre-action listener: _resource_record_pre_action 03:36:18 INFO - Running main action method: download_and_extract 03:36:18 INFO - mkdir: /builds/slave/test/build/tests 03:36:18 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')]} 03:36:18 INFO - https://queue.taskcluster.net/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:36:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:36:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:36:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/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 03:36:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/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 03:36:18 INFO - Downloaded 1361 bytes. 03:36:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:36:18 INFO - Using the following test package requirements: 03:36:18 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:36:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:36:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:36:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:18 INFO - u'jsshell-linux-x86_64.zip'], 03:36:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:36:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:36:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:36:18 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:36:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:36:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:36:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:36:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:36:18 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')]} 03:36:18 INFO - https://queue.taskcluster.net/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:36:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:36:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:36:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/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 03:36:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/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 03:36:23 INFO - Downloaded 22710854 bytes. 03:36:23 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'] 03:36:23 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 03:36:25 INFO - Return code: 0 03:36:25 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 03:36:25 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')]} 03:36:25 INFO - https://queue.taskcluster.net/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:36:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:36:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:36:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/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 03:36:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/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 03:36:28 INFO - Downloaded 22710854 bytes. 03:36:28 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'] 03:36:28 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 03:36:29 INFO - Return code: 0 03:36:29 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')]} 03:36:29 INFO - https://queue.taskcluster.net/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:36:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:36:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:36:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/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 03:36:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/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 03:36:31 INFO - Downloaded 14405518 bytes. 03:36:31 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'] 03:36:31 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 03:36:31 INFO - Return code: 0 03:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:31 INFO - https://queue.taskcluster.net/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:36:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:36:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:36:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/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 03:36:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyAIC98xQPeyxgImE1iYSg/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 03:36:38 INFO - Downloaded 56256648 bytes. 03:36:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:36:38 INFO - mkdir: /builds/slave/test/properties 03:36:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:36:38 INFO - Writing to file /builds/slave/test/properties/build_url 03:36:38 INFO - Contents: 03:36:38 INFO - build_url:https://queue.taskcluster.net/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:36:39 INFO - Running post-action listener: _resource_record_post_action 03:36:39 INFO - Running post-action listener: set_extra_try_arguments 03:36:39 INFO - ##### 03:36:39 INFO - ##### Finished download-and-extract step (success) 03:36:39 INFO - ##### 03:36:39 INFO - ##### 03:36:39 INFO - ##### Running populate-webroot step. 03:36:39 INFO - ##### 03:36:39 INFO - Running pre-action listener: _resource_record_pre_action 03:36:39 INFO - Running main action method: populate_webroot 03:36:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:36:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:36:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:36:39 INFO - '--tppagecycles', 03:36:39 INFO - '7'], 03:36:39 INFO - 'tests': ['tsvgm']}}, 03:36:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:36:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:36:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:36:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:36:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:36:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:36:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:39 INFO - 'talos_options': ['--disable-e10s'], 03:36:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:39 INFO - 'talos_options': ['--disable-e10s'], 03:36:39 INFO - 'tests': ['damp', 'tps']}, 03:36:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:39 INFO - 'tests': ['damp', 'tps']}, 03:36:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:36:39 INFO - 'tests': ['dromaeo_dom']}, 03:36:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:36:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:36:39 INFO - 'tests': ['basic_compositor_video']}, 03:36:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:36:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:36:39 INFO - 'tests': ['a11yr', 03:36:39 INFO - 'ts_paint', 03:36:39 INFO - 'tpaint', 03:36:39 INFO - 'sessionrestore', 03:36:39 INFO - 'sessionrestore_no_auto_restore', 03:36:39 INFO - 'tabpaint']}, 03:36:39 INFO - 'other-e10s': {'tests': ['a11yr', 03:36:39 INFO - 'ts_paint', 03:36:39 INFO - 'tpaint', 03:36:39 INFO - 'sessionrestore', 03:36:39 INFO - 'sessionrestore_no_auto_restore', 03:36:39 INFO - 'tabpaint']}, 03:36:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:36:39 INFO - 'ts_paint', 03:36:39 INFO - 'tpaint', 03:36:39 INFO - 'sessionrestore', 03:36:39 INFO - 'sessionrestore_no_auto_restore', 03:36:39 INFO - 'tabpaint']}, 03:36:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:36:39 INFO - 'ts_paint', 03:36:39 INFO - 'tpaint', 03:36:39 INFO - 'sessionrestore', 03:36:39 INFO - 'sessionrestore_no_auto_restore', 03:36:39 INFO - 'tabpaint']}, 03:36:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:36:39 INFO - 'tests': ['a11yr', 03:36:39 INFO - 'ts_paint', 03:36:39 INFO - 'tpaint', 03:36:39 INFO - 'sessionrestore', 03:36:39 INFO - 'sessionrestore_no_auto_restore', 03:36:39 INFO - 'tabpaint']}, 03:36:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:36:39 INFO - 'tests': ['a11yr', 03:36:39 INFO - 'ts_paint', 03:36:39 INFO - 'tpaint', 03:36:39 INFO - 'sessionrestore', 03:36:39 INFO - 'sessionrestore_no_auto_restore', 03:36:39 INFO - 'tabpaint']}, 03:36:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:36:39 INFO - 'tests': ['tsvgx', 03:36:39 INFO - 'tsvgr_opacity', 03:36:39 INFO - 'tart', 03:36:39 INFO - 'tscrollx', 03:36:39 INFO - 'cart']}, 03:36:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:36:39 INFO - 'tsvgr_opacity', 03:36:39 INFO - 'tart', 03:36:39 INFO - 'tscrollx', 03:36:39 INFO - 'cart']}, 03:36:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:39 INFO - 'talos_options': ['--disable-e10s'], 03:36:39 INFO - 'tests': ['tp5o']}, 03:36:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:39 INFO - 'tests': ['tp5o']}, 03:36:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:39 INFO - 'talos_options': ['--disable-e10s', 03:36:39 INFO - '--xperf_path', 03:36:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:39 INFO - 'tests': ['tp5n']}, 03:36:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:39 INFO - 'talos_options': ['--xperf_path', 03:36:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:39 INFO - 'tests': ['tp5n']}}, 03:36:39 INFO - 'talos.zip': {'path': '', 03:36:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:36:39 INFO - Running post-action listener: _resource_record_post_action 03:36:39 INFO - ##### 03:36:39 INFO - ##### Finished populate-webroot step (success) 03:36:39 INFO - ##### 03:36:39 INFO - ##### 03:36:39 INFO - ##### Running create-virtualenv step. 03:36:39 INFO - ##### 03:36:39 INFO - Running pre-action listener: _resource_record_pre_action 03:36:39 INFO - Running main action method: create_virtualenv 03:36:39 INFO - Creating virtualenv /builds/slave/test/build/venv 03:36:39 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 03:36:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:36:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:36:39 INFO - Using real prefix '/usr' 03:36:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:36:40 INFO - Installing distribute.............................................................................................................................................................................................done. 03:36:42 INFO - Installing pip.................done. 03:36:42 INFO - Return code: 0 03:36:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:36:42 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')]} 03:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:42 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')]} 03:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:42 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 0x7f6954b1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b1c0>, '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 0x1e7c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', '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 03:36:42 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 03:36:42 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 03:36:42 INFO - Using env: {'DISPLAY': ':0', 03:36:42 INFO - 'HOME': '/home/cltbld', 03:36:42 INFO - 'LANG': 'en_US.UTF-8', 03:36:42 INFO - 'LANGUAGE': 'en_US:en', 03:36:42 INFO - 'LOGNAME': 'cltbld', 03:36:42 INFO - 'MAIL': '/var/mail/cltbld', 03:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:42 INFO - 'MOZ_NO_REMOTE': '1', 03:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:42 INFO - 'NO_EM_RESTART': '1', 03:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:42 INFO - 'PWD': '/builds/slave/test', 03:36:42 INFO - 'SHELL': '/bin/bash', 03:36:42 INFO - 'SHLVL': '1', 03:36:42 INFO - 'TERM': 'linux', 03:36:42 INFO - 'TMOUT': '86400', 03:36:42 INFO - 'USER': 'cltbld', 03:36:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', 03:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:42 INFO - '_': '/tools/buildbot/bin/python'} 03:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:42 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 03:36:42 INFO - Cleaning up... 03:36:42 INFO - Return code: 0 03:36:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:36:42 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')]} 03:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:42 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')]} 03:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:42 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 0x7f6954b1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b1c0>, '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 0x1e7c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', '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 03:36:42 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 03:36:42 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 03:36:42 INFO - Using env: {'DISPLAY': ':0', 03:36:42 INFO - 'HOME': '/home/cltbld', 03:36:42 INFO - 'LANG': 'en_US.UTF-8', 03:36:42 INFO - 'LANGUAGE': 'en_US:en', 03:36:42 INFO - 'LOGNAME': 'cltbld', 03:36:42 INFO - 'MAIL': '/var/mail/cltbld', 03:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:42 INFO - 'MOZ_NO_REMOTE': '1', 03:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:42 INFO - 'NO_EM_RESTART': '1', 03:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:42 INFO - 'PWD': '/builds/slave/test', 03:36:42 INFO - 'SHELL': '/bin/bash', 03:36:42 INFO - 'SHLVL': '1', 03:36:42 INFO - 'TERM': 'linux', 03:36:42 INFO - 'TMOUT': '86400', 03:36:42 INFO - 'USER': 'cltbld', 03:36:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', 03:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:42 INFO - '_': '/tools/buildbot/bin/python'} 03:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:42 INFO - Downloading/unpacking psutil>=3.1.1 03:36:42 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 03:36:42 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 03:36:42 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 03:36:42 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 03:36:42 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 03:36:42 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 03:36:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:36:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:44 INFO - Installing collected packages: psutil 03:36:44 INFO - Running setup.py install for psutil 03:36:44 INFO - building 'psutil._psutil_linux' extension 03:36:44 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 03:36:44 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 03:36:44 INFO - building 'psutil._psutil_posix' extension 03:36:44 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 03:36:44 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 03:36:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:45 INFO - Successfully installed psutil 03:36:45 INFO - Cleaning up... 03:36:45 INFO - Return code: 0 03:36:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:36:45 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')]} 03:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:45 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')]} 03:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:45 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 0x7f6954b1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b1c0>, '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 0x1e7c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', '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 03:36:45 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 03:36:45 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 03:36:45 INFO - Using env: {'DISPLAY': ':0', 03:36:45 INFO - 'HOME': '/home/cltbld', 03:36:45 INFO - 'LANG': 'en_US.UTF-8', 03:36:45 INFO - 'LANGUAGE': 'en_US:en', 03:36:45 INFO - 'LOGNAME': 'cltbld', 03:36:45 INFO - 'MAIL': '/var/mail/cltbld', 03:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:45 INFO - 'MOZ_NO_REMOTE': '1', 03:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:45 INFO - 'NO_EM_RESTART': '1', 03:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:45 INFO - 'PWD': '/builds/slave/test', 03:36:45 INFO - 'SHELL': '/bin/bash', 03:36:45 INFO - 'SHLVL': '1', 03:36:45 INFO - 'TERM': 'linux', 03:36:45 INFO - 'TMOUT': '86400', 03:36:45 INFO - 'USER': 'cltbld', 03:36:45 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', 03:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:45 INFO - '_': '/tools/buildbot/bin/python'} 03:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:36:45 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 03:36:45 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 03:36:45 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 03:36:45 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 03:36:45 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 03:36:45 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 03:36:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:36:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:36:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:36:47 INFO - Installing collected packages: mozsystemmonitor 03:36:47 INFO - Running setup.py install for mozsystemmonitor 03:36:47 INFO - Successfully installed mozsystemmonitor 03:36:47 INFO - Cleaning up... 03:36:47 INFO - Return code: 0 03:36:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6954b1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b1c0>, '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 0x1e7c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', '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 03:36:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:36:47 INFO - Using env: {'DISPLAY': ':0', 03:36:47 INFO - 'HOME': '/home/cltbld', 03:36:47 INFO - 'LANG': 'en_US.UTF-8', 03:36:47 INFO - 'LANGUAGE': 'en_US:en', 03:36:47 INFO - 'LOGNAME': 'cltbld', 03:36:47 INFO - 'MAIL': '/var/mail/cltbld', 03:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:47 INFO - 'MOZ_NO_REMOTE': '1', 03:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:47 INFO - 'NO_EM_RESTART': '1', 03:36:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:47 INFO - 'PWD': '/builds/slave/test', 03:36:47 INFO - 'SHELL': '/bin/bash', 03:36:47 INFO - 'SHLVL': '1', 03:36:47 INFO - 'TERM': 'linux', 03:36:47 INFO - 'TMOUT': '86400', 03:36:47 INFO - 'USER': 'cltbld', 03:36:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', 03:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:47 INFO - '_': '/tools/buildbot/bin/python'} 03:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:47 INFO - Downloading/unpacking jsonschema==2.5.1 03:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:36:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:36: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 03:36: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 03:36: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 03:36: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 03:36: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 03:36: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 03:36:49 INFO - Downloading functools32-3.2.3-2.tar.gz 03:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:36:49 INFO - warning: no files found matching '*.txt' 03:36:49 INFO - no previously-included directories found matching 'build' 03:36:49 INFO - no previously-included directories found matching 'dist' 03:36:49 INFO - no previously-included directories found matching '.git*' 03:36:49 INFO - Installing collected packages: jsonschema, functools32 03:36:49 INFO - Running setup.py install for functools32 03:36:49 INFO - warning: no files found matching '*.txt' 03:36:49 INFO - no previously-included directories found matching 'build' 03:36:49 INFO - no previously-included directories found matching 'dist' 03:36:49 INFO - no previously-included directories found matching '.git*' 03:36:49 INFO - Successfully installed jsonschema functools32 03:36:49 INFO - Cleaning up... 03:36:49 INFO - Return code: 0 03:36:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6954b1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b1c0>, '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 0x1e7c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', '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 03:36:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:36:49 INFO - Using env: {'DISPLAY': ':0', 03:36:49 INFO - 'HOME': '/home/cltbld', 03:36:49 INFO - 'LANG': 'en_US.UTF-8', 03:36:49 INFO - 'LANGUAGE': 'en_US:en', 03:36:49 INFO - 'LOGNAME': 'cltbld', 03:36:49 INFO - 'MAIL': '/var/mail/cltbld', 03:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:49 INFO - 'MOZ_NO_REMOTE': '1', 03:36:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:50 INFO - 'NO_EM_RESTART': '1', 03:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:50 INFO - 'PWD': '/builds/slave/test', 03:36:50 INFO - 'SHELL': '/bin/bash', 03:36:50 INFO - 'SHLVL': '1', 03:36:50 INFO - 'TERM': 'linux', 03:36:50 INFO - 'TMOUT': '86400', 03:36:50 INFO - 'USER': 'cltbld', 03:36:50 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', 03:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:50 INFO - '_': '/tools/buildbot/bin/python'} 03:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:50 INFO - Downloading/unpacking blobuploader==1.2.4 03:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:52 INFO - Downloading blobuploader-1.2.4.tar.gz 03:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:36:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:36:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:52 INFO - Downloading docopt-0.6.1.tar.gz 03:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:36:52 INFO - Installing collected packages: blobuploader, requests, docopt 03:36:52 INFO - Running setup.py install for blobuploader 03:36:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:36:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:36:52 INFO - Running setup.py install for requests 03:36:53 INFO - Running setup.py install for docopt 03:36:53 INFO - Successfully installed blobuploader requests docopt 03:36:53 INFO - Cleaning up... 03:36:53 INFO - Return code: 0 03:36:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:53 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')]} 03:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:53 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')]} 03:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:53 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 0x7f6954b1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b1c0>, '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 0x1e7c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', '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 03:36:53 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 03:36:53 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 03:36:53 INFO - Using env: {'DISPLAY': ':0', 03:36:53 INFO - 'HOME': '/home/cltbld', 03:36:53 INFO - 'LANG': 'en_US.UTF-8', 03:36:53 INFO - 'LANGUAGE': 'en_US:en', 03:36:53 INFO - 'LOGNAME': 'cltbld', 03:36:53 INFO - 'MAIL': '/var/mail/cltbld', 03:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:53 INFO - 'MOZ_NO_REMOTE': '1', 03:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:53 INFO - 'NO_EM_RESTART': '1', 03:36:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:53 INFO - 'PWD': '/builds/slave/test', 03:36:53 INFO - 'SHELL': '/bin/bash', 03:36:53 INFO - 'SHLVL': '1', 03:36:53 INFO - 'TERM': 'linux', 03:36:53 INFO - 'TMOUT': '86400', 03:36:53 INFO - 'USER': 'cltbld', 03:36:53 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', 03:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:53 INFO - '_': '/tools/buildbot/bin/python'} 03:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:53 INFO - Running setup.py (path:/tmp/pip-z4JqRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:53 INFO - Running setup.py (path:/tmp/pip-NZXFEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:53 INFO - Running setup.py (path:/tmp/pip-wG2fUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:53 INFO - Running setup.py (path:/tmp/pip-cTn6Ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:53 INFO - Running setup.py (path:/tmp/pip-n2efWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:54 INFO - Running setup.py (path:/tmp/pip-lB99i5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:54 INFO - Running setup.py (path:/tmp/pip-MulHvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:54 INFO - Running setup.py (path:/tmp/pip-v6XL7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:54 INFO - Running setup.py (path:/tmp/pip-o_jfBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:54 INFO - Running setup.py (path:/tmp/pip-0_0wnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:54 INFO - Running setup.py (path:/tmp/pip-RAKImZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:54 INFO - Running setup.py (path:/tmp/pip-5BvZrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:54 INFO - Running setup.py (path:/tmp/pip-HtnIah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:54 INFO - Running setup.py (path:/tmp/pip-9BX9lY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:54 INFO - Running setup.py (path:/tmp/pip-XqpqAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:54 INFO - Running setup.py (path:/tmp/pip-4P0hWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:54 INFO - Running setup.py (path:/tmp/pip-Wj8Ebi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:36:54 INFO - Running setup.py install for manifestparser 03:36:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:36:54 INFO - Running setup.py install for mozcrash 03:36:55 INFO - Running setup.py install for mozdebug 03:36:55 INFO - Running setup.py install for mozdevice 03:36:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:36:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:36:55 INFO - Running setup.py install for mozfile 03:36:55 INFO - Running setup.py install for mozhttpd 03:36:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:36:55 INFO - Running setup.py install for mozinfo 03:36:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:36:55 INFO - Running setup.py install for mozInstall 03:36:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:36:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:36:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:36:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:36:55 INFO - Running setup.py install for mozleak 03:36:55 INFO - Running setup.py install for mozlog 03:36:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:36:55 INFO - Running setup.py install for moznetwork 03:36:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:36:56 INFO - Running setup.py install for mozprocess 03:36:56 INFO - Running setup.py install for mozprofile 03:36:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:36:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:36:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:36:56 INFO - Running setup.py install for mozrunner 03:36:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:36:56 INFO - Running setup.py install for mozscreenshot 03:36:56 INFO - Running setup.py install for moztest 03:36:56 INFO - Running setup.py install for mozversion 03:36:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:36:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:36:56 INFO - Cleaning up... 03:36:56 INFO - Return code: 0 03:36:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:56 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 0x7f6954b1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b1c0>, '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 0x1e7c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', '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 03:36:56 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 03:36:56 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 03:36:56 INFO - Using env: {'DISPLAY': ':0', 03:36:56 INFO - 'HOME': '/home/cltbld', 03:36:56 INFO - 'LANG': 'en_US.UTF-8', 03:36:56 INFO - 'LANGUAGE': 'en_US:en', 03:36:56 INFO - 'LOGNAME': 'cltbld', 03:36:56 INFO - 'MAIL': '/var/mail/cltbld', 03:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:56 INFO - 'MOZ_NO_REMOTE': '1', 03:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:56 INFO - 'NO_EM_RESTART': '1', 03:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:56 INFO - 'PWD': '/builds/slave/test', 03:36:56 INFO - 'SHELL': '/bin/bash', 03:36:56 INFO - 'SHLVL': '1', 03:36:56 INFO - 'TERM': 'linux', 03:36:56 INFO - 'TMOUT': '86400', 03:36:56 INFO - 'USER': 'cltbld', 03:36:56 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', 03:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:56 INFO - '_': '/tools/buildbot/bin/python'} 03:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:56 INFO - Running setup.py (path:/tmp/pip-NYeRBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:56 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)) 03:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:56 INFO - Running setup.py (path:/tmp/pip-0gYAEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:57 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)) 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:57 INFO - Running setup.py (path:/tmp/pip-bWo9DO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:57 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)) 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:57 INFO - Running setup.py (path:/tmp/pip-b8P407-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:57 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)) 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:57 INFO - Running setup.py (path:/tmp/pip-lH1iov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:57 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)) 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:57 INFO - Running setup.py (path:/tmp/pip-GU0WVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:57 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)) 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:57 INFO - Running setup.py (path:/tmp/pip-8liomq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:57 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)) 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:57 INFO - Running setup.py (path:/tmp/pip-2MUJhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:57 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)) 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:57 INFO - Running setup.py (path:/tmp/pip-vckWR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:57 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)) 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:57 INFO - Running setup.py (path:/tmp/pip-oRQVmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:57 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)) 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:57 INFO - Running setup.py (path:/tmp/pip-MZ2jPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:57 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)) 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:57 INFO - Running setup.py (path:/tmp/pip-3Y1xyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:57 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)) 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:57 INFO - Running setup.py (path:/tmp/pip-_yeGbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:57 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)) 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:57 INFO - Running setup.py (path:/tmp/pip-TAXAiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:57 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)) 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:57 INFO - Running setup.py (path:/tmp/pip-XJepOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:58 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)) 03:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:58 INFO - Running setup.py (path:/tmp/pip-ViHy_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:58 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)) 03:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:58 INFO - Running setup.py (path:/tmp/pip-Q9qA9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:58 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)) 03:36:58 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)) 03:36:58 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)) 03:36:58 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)) 03:36:58 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)) 03:36:58 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)) 03:36:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:36:58 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 03:36:58 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 03:36:58 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 03:36:58 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 03:36:58 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 03:36:58 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 03:37:00 INFO - Downloading blessings-1.6.tar.gz 03:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:37:00 INFO - Installing collected packages: blessings 03:37:00 INFO - Running setup.py install for blessings 03:37:00 INFO - Successfully installed blessings 03:37:00 INFO - Cleaning up... 03:37:00 INFO - Return code: 0 03:37:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:37:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:00 INFO - Reading from file tmpfile_stdout 03:37:00 INFO - Current package versions: 03:37:00 INFO - argparse == 1.2.1 03:37:00 INFO - blessings == 1.6 03:37:00 INFO - blobuploader == 1.2.4 03:37:00 INFO - docopt == 0.6.1 03:37:00 INFO - functools32 == 3.2.3-2 03:37:00 INFO - jsonschema == 2.5.1 03:37:00 INFO - manifestparser == 1.1 03:37:00 INFO - mozInstall == 1.12 03:37:00 INFO - mozcrash == 0.17 03:37:00 INFO - mozdebug == 0.1 03:37:00 INFO - mozdevice == 0.48 03:37:00 INFO - mozfile == 1.2 03:37:00 INFO - mozhttpd == 0.7 03:37:00 INFO - mozinfo == 0.9 03:37:00 INFO - mozleak == 0.1 03:37:00 INFO - mozlog == 3.2 03:37:00 INFO - moznetwork == 0.27 03:37:00 INFO - mozprocess == 0.22 03:37:00 INFO - mozprofile == 0.28 03:37:00 INFO - mozrunner == 6.11 03:37:00 INFO - mozscreenshot == 0.1 03:37:00 INFO - mozsystemmonitor == 0.3 03:37:00 INFO - moztest == 0.7 03:37:00 INFO - mozversion == 1.4 03:37:00 INFO - psutil == 3.1.1 03:37:00 INFO - requests == 1.2.3 03:37:00 INFO - wsgiref == 0.1.2 03:37:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:00 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')]} 03:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:00 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')]} 03:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:00 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 0x7f6954b1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b1c0>, '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 0x1e7c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', '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 03:37:00 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 03:37:00 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 03:37:00 INFO - Using env: {'DISPLAY': ':0', 03:37:00 INFO - 'HOME': '/home/cltbld', 03:37:00 INFO - 'LANG': 'en_US.UTF-8', 03:37:00 INFO - 'LANGUAGE': 'en_US:en', 03:37:00 INFO - 'LOGNAME': 'cltbld', 03:37:00 INFO - 'MAIL': '/var/mail/cltbld', 03:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:00 INFO - 'MOZ_NO_REMOTE': '1', 03:37:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:00 INFO - 'NO_EM_RESTART': '1', 03:37:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:00 INFO - 'PWD': '/builds/slave/test', 03:37:00 INFO - 'SHELL': '/bin/bash', 03:37:00 INFO - 'SHLVL': '1', 03:37:00 INFO - 'TERM': 'linux', 03:37:00 INFO - 'TMOUT': '86400', 03:37:00 INFO - 'USER': 'cltbld', 03:37:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', 03:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:00 INFO - '_': '/tools/buildbot/bin/python'} 03:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:00 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)) 03:37:00 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)) 03:37:00 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)) 03:37:00 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)) 03:37:00 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)) 03:37:00 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)) 03:37:00 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)) 03:37:00 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)) 03:37:00 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)) 03:37:00 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)) 03:37:00 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)) 03:37:00 INFO - Cleaning up... 03:37:00 INFO - Return code: 0 03:37:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:37:00 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')]} 03:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:00 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')]} 03:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:00 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 0x7f6954b1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b1c0>, '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 0x1e7c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', '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 03:37:00 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 03:37:00 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 03:37:00 INFO - Using env: {'DISPLAY': ':0', 03:37:00 INFO - 'HOME': '/home/cltbld', 03:37:00 INFO - 'LANG': 'en_US.UTF-8', 03:37:00 INFO - 'LANGUAGE': 'en_US:en', 03:37:00 INFO - 'LOGNAME': 'cltbld', 03:37:00 INFO - 'MAIL': '/var/mail/cltbld', 03:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:00 INFO - 'MOZ_NO_REMOTE': '1', 03:37:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:00 INFO - 'NO_EM_RESTART': '1', 03:37:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:00 INFO - 'PWD': '/builds/slave/test', 03:37:00 INFO - 'SHELL': '/bin/bash', 03:37:00 INFO - 'SHLVL': '1', 03:37:00 INFO - 'TERM': 'linux', 03:37:00 INFO - 'TMOUT': '86400', 03:37:00 INFO - 'USER': 'cltbld', 03:37:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', 03:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:00 INFO - '_': '/tools/buildbot/bin/python'} 03:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:37:00 INFO - Cleaning up... 03:37:00 INFO - Return code: 0 03:37:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:37:00 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')]} 03:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:00 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')]} 03:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:00 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 0x7f6954b1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dec350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b1c0>, '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 0x1e7c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c550>, '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': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', '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 03:37:00 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 03:37:00 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 03:37:00 INFO - Using env: {'DISPLAY': ':0', 03:37:00 INFO - 'HOME': '/home/cltbld', 03:37:00 INFO - 'LANG': 'en_US.UTF-8', 03:37:00 INFO - 'LANGUAGE': 'en_US:en', 03:37:00 INFO - 'LOGNAME': 'cltbld', 03:37:00 INFO - 'MAIL': '/var/mail/cltbld', 03:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:00 INFO - 'MOZ_NO_REMOTE': '1', 03:37:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:00 INFO - 'NO_EM_RESTART': '1', 03:37:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:00 INFO - 'PWD': '/builds/slave/test', 03:37:00 INFO - 'SHELL': '/bin/bash', 03:37:00 INFO - 'SHLVL': '1', 03:37:00 INFO - 'TERM': 'linux', 03:37:00 INFO - 'TMOUT': '86400', 03:37:00 INFO - 'USER': 'cltbld', 03:37:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', 03:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:00 INFO - '_': '/tools/buildbot/bin/python'} 03:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:01 INFO - Downloading/unpacking flake8 03:37:01 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 03:37:01 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 03:37:01 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 03:37:01 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 03:37:01 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 03:37:01 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 03:37:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:37:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:37:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:37:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:37:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:37:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:37:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:37:03 INFO - no previously-included directories found matching 'docs/_build' 03:37:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:37:03 INFO - Running setup.py install for pep8 03:37:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:37:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:37:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:37:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:37:03 INFO - no previously-included directories found matching 'docs/_build' 03:37:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:37:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:37:04 INFO - Cleaning up... 03:37:04 INFO - Return code: 0 03:37:04 INFO - Running post-action listener: _resource_record_post_action 03:37:04 INFO - Running post-action listener: _start_resource_monitoring 03:37:04 INFO - Starting resource monitoring. 03:37:04 INFO - ##### 03:37:04 INFO - ##### Finished create-virtualenv step (success) 03:37:04 INFO - ##### 03:37:04 INFO - ##### 03:37:04 INFO - ##### Running install step. 03:37:04 INFO - ##### 03:37:04 INFO - Running pre-action listener: _resource_record_pre_action 03:37:04 INFO - Running main action method: install 03:37:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:04 INFO - Reading from file tmpfile_stdout 03:37:04 INFO - Detecting whether we're running mozinstall >=1.0... 03:37:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:37:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:37:04 INFO - Reading from file tmpfile_stdout 03:37:04 INFO - Output received: 03:37:04 INFO - Usage: mozinstall [options] installer 03:37:04 INFO - Options: 03:37:04 INFO - -h, --help show this help message and exit 03:37:04 INFO - -d DEST, --destination=DEST 03:37:04 INFO - Directory to install application into. [default: 03:37:04 INFO - "/builds/slave/test"] 03:37:04 INFO - --app=APP Application being installed. [default: firefox] 03:37:04 INFO - mkdir: /builds/slave/test/build/application 03:37:04 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'] 03:37:04 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 03:37:20 INFO - Reading from file tmpfile_stdout 03:37:20 INFO - Output received: 03:37:20 INFO - /builds/slave/test/build/application/firefox/firefox 03:37:20 INFO - Running post-action listener: _resource_record_post_action 03:37:20 INFO - ##### 03:37:20 INFO - ##### Finished install step (success) 03:37:20 INFO - ##### 03:37:20 INFO - ##### 03:37:20 INFO - ##### Running run-tests step. 03:37:20 INFO - ##### 03:37:20 INFO - Running pre-action listener: _resource_record_pre_action 03:37:20 INFO - Running main action method: run_tests 03:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:37:20 INFO - Python 2.7.3 03:37:20 INFO - Return code: 0 03:37:20 INFO - grabbing minidump binary from tooltool 03:37: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')]} 03:37:20 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 0x1e7b1c0>, '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 0x1e7c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:37:20 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 03:37:20 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 03:37:20 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 03:37:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:37:20 INFO - Return code: 0 03:37:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:37:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:37:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:37:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:37:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:37:21 INFO - Return code: 0 03:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:37:21 INFO - Using env: {'DISPLAY': ':0', 03:37:21 INFO - 'HOME': '/home/cltbld', 03:37:21 INFO - 'LANG': 'en_US.UTF-8', 03:37:21 INFO - 'LANGUAGE': 'en_US:en', 03:37:21 INFO - 'LOGNAME': 'cltbld', 03:37:21 INFO - 'MAIL': '/var/mail/cltbld', 03:37:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:37:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:21 INFO - 'MOZ_NO_REMOTE': '1', 03:37:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:21 INFO - 'NO_EM_RESTART': '1', 03:37:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:21 INFO - 'PWD': '/builds/slave/test', 03:37:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:37:21 INFO - 'SHELL': '/bin/bash', 03:37:21 INFO - 'SHLVL': '1', 03:37:21 INFO - 'TERM': 'linux', 03:37:21 INFO - 'TMOUT': '86400', 03:37:21 INFO - 'USER': 'cltbld', 03:37:21 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240', 03:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:21 INFO - '_': '/tools/buildbot/bin/python'} 03:37:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:37:21 INFO - mozversion application_buildid: 20160624021502 03:37:21 INFO - mozversion application_changeset: 939ecc4e9d055c263633cbe276bfb634a68fe4c5 03:37:21 INFO - mozversion application_display_name: Nightly 03:37:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:37:21 INFO - mozversion application_name: Firefox 03:37:21 INFO - mozversion application_remotingname: firefox 03:37:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:37:21 INFO - mozversion application_vendor: Mozilla 03:37:21 INFO - mozversion application_version: 50.0a1 03:37:21 INFO - mozversion platform_buildid: 20160624021502 03:37:21 INFO - mozversion platform_changeset: 939ecc4e9d055c263633cbe276bfb634a68fe4c5 03:37:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:37:21 INFO - mozversion platform_version: 50.0a1 03:37:21 INFO - using testdate: 1466764641 03:37:21 INFO - actual date: 1466764641 03:37:21 INFO - starting webserver on 'localhost:57377' 03:37:21 INFO - SUITE-START | Running 2 tests 03:37:21 INFO - TEST-START | dromaeo_css 03:37:21 INFO - operating with platform_type : linux_ 03:37:21 INFO - Initialising browser for dromaeo_css test... 03:37:21 INFO - TEST-INFO | started process 10041 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiZINiE/profile http://localhost:57377/getInfo.html) 03:37:26 INFO - PROCESS | 10041 | __metrics Screen width/height:1600/1200 03:37:26 INFO - PROCESS | 10041 | colorDepth:24 03:37:26 INFO - PROCESS | 10041 | Browser inner width/height: 1024/697 03:37:26 INFO - PROCESS | 10041 | __metrics 03:37:27 INFO - PROCESS | 10041 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:37:28 INFO - TEST-INFO | 10041: exit 0 03:37:28 INFO - Browser initialized. 03:37:28 INFO - Running cycle 1/1 for dromaeo_css test... 03:37:28 INFO - TEST-INFO | started process 10120 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiZINiE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:40 INFO - PROCESS | 10120 | RSS: Main: 175644672 03:37:40 INFO - PROCESS | 10120 | 03:38:32 INFO - PROCESS | 10120 | 1466764712216 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] 03:40:44 INFO - PROCESS | 10120 | Cycle 1(1): loaded http://localhost:57377/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57377/tests/dromaeo/cssquery-ext.html) 03:40:45 INFO - PROCESS | 10120 | RSS: Main: 288190464 03:40:45 INFO - PROCESS | 10120 | 03:43:47 INFO - PROCESS | 10120 | Cycle 1(1): loaded http://localhost:57377/tests/dromaeo/cssquery-ext.html (next: http://localhost:57377/tests/dromaeo/cssquery-jquery.html) 03:43:48 INFO - PROCESS | 10120 | RSS: Main: 255922176 03:43:48 INFO - PROCESS | 10120 | 03:46:50 INFO - PROCESS | 10120 | Cycle 1(1): loaded http://localhost:57377/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57377/tests/dromaeo/cssquery-mootools.html) 03:46:51 INFO - PROCESS | 10120 | RSS: Main: 259735552 03:46:51 INFO - PROCESS | 10120 | 03:49:53 INFO - PROCESS | 10120 | Cycle 1(1): loaded http://localhost:57377/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57377/tests/dromaeo/cssquery-prototype.html) 03:49:54 INFO - PROCESS | 10120 | RSS: Main: 255053824 03:49:54 INFO - PROCESS | 10120 | 03:52:57 INFO - PROCESS | 10120 | Cycle 1(1): loaded http://localhost:57377/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57377/tests/dromaeo/cssquery-yui.html) 03:52:57 INFO - PROCESS | 10120 | RSS: Main: 225439744 03:52:57 INFO - PROCESS | 10120 | 03:56:00 INFO - PROCESS | 10120 | Cycle 1(1): loaded http://localhost:57377/tests/dromaeo/cssquery-yui.html (next: http://localhost:57377/tests/dromaeo/cssquery-dojo.html) 03:56:00 INFO - PROCESS | 10120 | RSS: Main: 305664000 03:56:00 INFO - PROCESS | 10120 | 03:56:00 INFO - PROCESS | 10120 | __start_tp_report 03:56:00 INFO - PROCESS | 10120 | _x_x_mozilla_page_load 03:56:00 INFO - PROCESS | 10120 | _x_x_mozilla_page_load_details 03:56:00 INFO - PROCESS | 10120 | |i|pagename|runs| 03:56:00 INFO - PROCESS | 10120 | |0;dojo.html;2668.1995401379586;2695.5417579011564;2715.5247831629467;2736.657917760281;2739.3973325868315;4706.3411122442885;4767.523247675235;4781.258904869742;4894.2413925841465;4944.456109827916;4722.3860898083285;4751.786169622366;4758.286257061434;4776.044791041797;4780.904381912368;4358.43340365752;4420.093880754438;4455.732656040648;4484.8878778030485;4590.42619672541;4515.05183911379;4526.886827829314;4539.477960034589;4566.931496027546;4580.1984652685815;4305.935410968838;4348.173846969065;4351.325544540601;4425.911481770347;4439.88900277494;4428.291473364278;4434.667399945017;4440.533743956903;4448.888777780549;4529.9547004530195;4451.554844515555;4455.910881782379;4474.127545128701;4501.7524036178;4513.593776560093;4721.905561888743;4777.307290442901;4874.049560335736;4888.73111978841;4933.45731969483;5135.152699804527;5240.187770895517;5242;5242.397124330712;5246.685198888079;5222.97388513055;5230.843074707765;5245.737713114329;5258.2638430619745;5281.815136470205;4673.696209746356;4776.641751868554;4823.1800593898415;4873.512648735169;4920.335754673145;5327.094393953037;5327.653702509325;5331.3868905076415;5371.221172929982;5374.731263436813;5149.330587023663;5159.432462429205;5166.974165129151;5170.1986192140275;5170.948290517122;5054.393472783289;5090.643654944119;5119.462456442095;5131.102057139986;5246.711430871263;5126.820561280338;5135.87160320995;5137.871553211125;5166.147585648326;5167.431582525919;5119.692818430906;5121.61587880903;5137.101007323703;5139.614528910347;5190.92213616796;4249.128928569698;4266.829326826892;4292.484901811803;4336.6313863321975;4377.409049778239;3734.3464893643504;3745.9885830825524;3753.042974041602;3763.9435408468894;3817.923641527154;4402.911941761146;4436;4451.933221001687;4491.752953587584;4496.9881776600005;5039.84880453587;5073.365829271341;5094.6688465249645;5175.844724658191;5232.189010703347;4423.668224883147;4453.710508816981;4454.265046267395;4486.214912390318;4500.392447019676;4633.7683115844075;4651.86044418668;4654.581087702123;4657.208274593328;4699.2481203007355;4713.9764301178275;4767.070421267819;4817.108834865561;4863.9513604864205;4877.609791216623;5142.97428512855;5165.974170129276;5167.044096842096;5167.767450464663;5198.116320225495;4821.590164836029;4831.95168048315;4842.951570484391;4844.8304309350415;4878.243872199815;4991.425986011655;5112.872178195426;5117.053345131163;5130.307408499954;5176.197689358156;5251.868703282448;5257.89484210306;5260.684358938476;5275.129603615361;5278.181881808326;5121.308623335802;5122.846314610568;5124.231365295086;5125.5899528036925;5126.487351264844;4850.7574621269505;4924.778384972613;4950.925736113889;4972.105021096238;5014.924776128434;4902.166631672553;4926.729029903247;5003.099442100457;5005.849824505271;5013.523715247045;4944.258361245842;5064.772085256246;5064.82273120439;5069.822556210515;5072.4673909239;4830.686005409637;4882.584980276716;4895.46149923501;4933.210686290176;5011.649184557046 03:56:00 INFO - PROCESS | 10120 | |1;ext.html;535.6217522483037;576.5704550110167;579.3887448741579;580.4891695308128;628.0077477585415;26864.32839179019;29611.259718507048;29625.851870740644;29710.25724356892;38902;40305.39541906866;40427.19145617086;40637.59362406375;40682.7965860171;40713.38929916046;7708.036495438084;7862.410319226053;7863.37093032556;7866.724664636738;7878.881816772753;7478.401727861785;7773.183815699355;9997.100260976511;10248.282620216587;10271.17830573556;10302.22733295002;10356.17150627948;10357.741056473573;10364.429956352398;10383.117435018032;7517.060367454068;10263.230257730662;10294.691159265234;10301.639442619547;10317.79364412715;9414.43513389192;10140.239482038876;10235.948820255926;10638.893611063868;10644.201684873666;35883.102922426886;36425.453618195745;39720.404193937116;39835.20329593392;39842;3105.6894310568987;3128.1553980425383;3131.0763324819004;3169.239382548195;3225.5322978168033;29505.409891802257;29888.70111298881;30247.243818904484;30359.69640303591;30894.845525772453;3462.4286992646184;3560.964390356089;3564.7682900611376;3577.713782897362;3586.2468881534646;270778.2922170773;271717;271905;271975;271983.6400818003;57316.71341643265;58259.4174058254;58294.708526457944;58305.416945830846;58337.4166258332;33762.83118584441;34717;34780.478292825625;37023.444648330296;64018.67990660017;13796.172229666252;13930.721385572231;13940.093893896865;13955.162690238618;13969.930150349182;9131.543422828965;10247;10620.787584248272;10743.14054875608;10753.892461075446;19226.134823932956;19291.710624340645;19364.322248721226;19365.4190374289;19371.225150994083;7132.322429369202;7218.566885986857;7224.602646854369;7272.345488905918;7450.0687414073245;764.4801534956283;876.2332958661171;993.7217579077869;1004.7136566078633;1046.853440518328;27729.306767330978;28520;28653.283667908054;28868.42263154725;28963.42073158525;912.8539433690711;914.3690853311194;975.5171190260725;985.3398223190479;1059.761553650438;14791.482298119729;15103.169325686973;15229.466968656045;15242.542723718085;15485.612859678598;395446;398083;399233;399881;400707;50408.747956259984;51059.48940510547;51135;51155.232671509955;51157.48842511527;1069.769999450122;1158.8377627132209;1194.0865238092865;1201.867794542617;1214.4110106598293;27779.86110069437;29192.708072919;29244.561331579618;29272.853635731684;29293.560596590643;36566.817165914;36936.26127477382;36967.63032369749;37157.25685486329;37230;237052;237722;238071;238251;238295;20536.691949621065;39726.80136599414;40114.1977160461;40792.3881141789;40858.182836342516;43123.56876431195;43644.78177609092;43963.34054989242;44268.7786561078;44575.33137002883;36667.26665466622;37407.6259237415;37516;37725.62274377221;38018.2396352077;37058.80882757263;37413.625863741014;38262.80868595639;38322.80838595789;38540.6145938537;36399.47437582061;36897.44653830141;37324.440133398566;37825.24349512939;37878;32089.518657220626;34006.48990265099;34236.31527369488;34407.65592344045;34738.82630586831;25513.48973020492;25733;25881.482370352864;25891.61162582525;26038.218853434428 03:56:00 INFO - PROCESS | 10120 | |2;jquery.html;367.42497990644637;367.8179301245884;370.93137769512623;376.6911132871046;390.91986142840705;15678.372865085397;16693;17255.396061137864;17269.568260793487;17289.567760805956;14665.780013299782;15815.130167840764;16033.118178500177;16211.51365459038;16485.258163382645;4851.708897466155;5047.899042019158;5079.3142925705115;5087.56755675768;5089.592832573404;3677.191017976041;3880.2239552089695;4960.702357858522;5622.184783206432;5973.4026597340135;5922.4373684500115;5933.436323549277;5955.1960485334575;6011.128386383972;6017.338092809788;5678.4605462480995;5935.406459354052;5937.2578427696535;5940.435658612425;5945.940540594582;3332.23358627517;4913.484084171147;5244.580433565306;5249.658772179796;5250.18622113573;19074.427767167006;19127.330543431053;19147.234110635698;19578.118984645724;19648.90175549113;1942.417274817563;1948.3278268997174;1999.380192140441;2008.2167954497756;2059.660156074246;12647.49410023598;12830.230186188764;12900.935495322557;12910.935445322808;13481.59555213345;1717.4933394648608;1720.4838548435544;1729.3342063305593;1731.2469075952001;1837.0263760207113;64366.3563364365;66148;66225;67557.3244267556;68079.31920680829;9362.719118426457;9426;9683.128518433376;9780.41317520951;9932.602695892083;13440.395182216824;13486.325683715775;13530.594082177551;13541.932290338485;13554.118982266122;7259.89110163348;7388.519746216479;7411.407087432993;7416.40668746499;7510;6967.686454109577;7106.964465177641;7110.146782386147;7127.786166415016;7128.251533589002;6045.6070355426755;6118.724657390339;6148.8770224595255;6208.596441231396;6253.280872699698;1535.4702627593463;1641.1876121320024;1715.6054107555083;1722.2336060453229;1724.741288806689;842.650300125441;863.3869952333788;863.4819108534955;917.738444543302;948.4783369147079;16265.268062937197;16399.83600163983;16918.830811691972;16984.915075424542;17141;845.6532821543137;856.5931182688173;868.392125512144;910.6767097680228;984.7095106943469;9037.728868133834;9884.159846413135;9938.950305248572;10168.796624067478;10170.135538479164;388506;390635;391405;394246;404709;81262.18737812665;81370.59314703388;83211;83398.58300708457;84725.06924515225;888.7467071884482;909.7316291694099;921.7511271956535;923.9076092390842;924.5192499900014;15388.384464621737;15754.684906302038;15904.681906362039;16129;16170.919145404197;36231.63768362282;37275.25449491049;37278.6272137286;38474.230515388976;39177.6082239174;47877.28184077311;48490;48788.75605622091;49015.75492122517;55229.723851380484;6502.804915852532;7010.47421443404;7253.165885923187;7288.489805713549;7307.890381644386;10839.512221950188;11570.537178512765;11729.530818767154;11789.410529473664;11802.76394472123;6965.407940325129;7630.702780527435;9698.224142068759;9981.550830212513;9995.300328976902;4948.678335908155;7892.723754668559;9449.055094490495;10357.4303413313;10458.790824183627;9378.249740020918;9546.90453095488;9793.608255669978;9807.06832850878;10088.243381746252;7024.5434046786795;7053.717851285891;7091.255418181223;7103.467239957127;7291.234420385783;9016.86474702893;9642.662506812228;9745.506815266755;9912.900870991487;10182.287239893136 03:56:00 INFO - PROCESS | 10120 | |3;mootools.html;1219.3598360860542;1391.4503771010452;1422.5092343141614;1521.8478152184782;1727.1882215358785;7472.589007604586;7834.608269586526;7859.489133206344;8080.757577272677;8121.512709237435;7828.099768526621;7975;7985.92014079859;7999;8005;1852.3239017758556;1915;1920.9039548022613;2203.7796220377954;2232.57581059599;1935.7096435534643;2115.3336698939784;2184.8798316092607;2188.6935828983956;2207.624703800358;2205.007746514067;2211.292386436341;2228.565429741193;2229.9296337757887;2229.9888500557477;1817.7273408988626;2192.2655910270078;2196.758356580775;2198.087793565668;2200.2409168836807;2082.9687554686693;2135.519508110678;2142.046789178816;2153.052656831005;2158.3848603148026;7999.520028798291;8019.037715474122;8047.23551262635;8047.798805029863;8059.63731632078;4457;4566.4520257568975;4568.862934111949;4572.1312950539295;4572.9314060289125;2817.4646817104685;2906.593076969226;2929.2383980165096;2988.2379993101836;2991.0428662827903;893.7452825944574;911.4121391702381;946.7822400847774;957.1911734584265;961.9422834629945;10580.206484513692;10662.946685266601;10663.786724265548;10681.679549613524;10684.679459616224;4103.753774773463;4171.457710497616;4244.066305412866;4267.039916018933;4276.978615106905;8918.866217006751;9027.322950778718;9043.728688139367;9068.274538036942;9068.410553314014;4476.283794592915;4550.135474259946;4554.681172317906;4558.88602784933;4560.087982403466;3418.8119653418803;3739.1960728443514;4187.66498680111;4189.748615083044;4191.161767646483;3583.749137560346;3657.9817100914856;3726.64596863303;3735.34631439497;3745.250949810049;1184.6564496295978;1206.9879301207052;1215.5927764198916;1221.9369148840565;1225.7977433723513;707.8230442389403;788.9960550197212;801.8773716796532;810.3719617296642;830.1781236575747;4956.776945037482;5079.547253443085;5114.514121158559;5203.557697595671;5340.706261155596;407.4234957535114;884.9557522123997;889.7953470701775;890.5680744838749;907.4237858959608;3356.697897189216;3386.102682789063;3396.524486571882;3438.415469370213;3501.439769636846;9724.17344525709;9761.9023809761;9801.411915284963;9853.704388868346;10019.549120289605;9695.127438530426;9701.805963880824;9706.951465242628;9798;9809.607615695435;7321.414286857039;7550.886736698954;7574.99999999989;7588.734394296173;7601.391888648895;4967.620867989684;5081.364829396325;5090.720010399464;5232.869178270574;5313.309269794902;9057.365984381293;9294.767630809283;9303.976562577976;9323.813523729352;9329.346945713734;9091.909080909107;9333.579988900652;9532.23742100644;9544.761380965532;9545.952270238604;6822.624755638488;7068.82327941785;7148.714051437884;7154.105736782903;7154.534955227893;7489.737859174903;7495.850082998419;7527.510711803715;7534.246575342422;7545.283198096172;6369.9681501592195;6598.802035938929;6638.5684930479365;6665.2334981475815;6788.151481064867;6443.162388889415;6470.061841033118;6535.44448721864;6539.967300163468;6542.476601871934;5976.073708575178;6187.381261873777;6231.657258850807;6295;6306.180196574416;4577.793999269974;4607.792649330721;4619.191641462798;4658.208104622155;4731.337612734151;4797.571254518962;4824.131656301899;4835.734034628129;4846.733429661262;4931.926021109614 03:56:00 INFO - PROCESS | 10120 | |4;prototype.html;304.8780487804878;311.3042350346974;311.48915778123876;314.7183270972481;315.8689144005238;4828.130936431441;4895.265710143472;4910.779014944327;4913.729744864036;4934.827281045164;4815.446223684277;4817.783199756011;4831.347768051312;4843.9757801211035;4863.221884498472;3615.8734444294455;3721.51620289362;3740.9438858417147;3861.9806900965455;3903.882883513499;3806.885793426202;3841.7118716096265;3849.6727778138893;3868.6711629511524;3883.3786594144945;3654.543182102237;3791.5829258781514;3803.923921521568;3812.8474861005666;3813.0657988792786;3567.839447224881;3771.622837716234;3772.9434058489146;3783.527059117624;3789.621037896216;3379.3241351729507;3381.9492707609406;3385.1367901185286;3392.8982130536124;3411.385950528904;4727.5272472752795;4741.2651039089;4743.193657078305;4753.928691069636;4785.593224575915;4267.95435118398;4334.956650433487;4336.956630433687;4357.150355680644;4368.541303163154;5034.773435195389;5047.268146118792;5085.364329458817;5112.872178195537;5117.590592752571;3715.498407714951;3725.1990821973136;3731.1791405890663;3734.3278209922205;3745.75652582584;5113.2330150477355;5288.524032837063;5313.57491400687;5337.653052551572;5339.145736682151;3771.9245615088093;3771.962280377216;3785.545734511821;3787.223619158066;3814.3515602347666;3839.500864887603;3851.114243723959;3855.6505223171666;3866.284737323604;3869.877735456686;4294.828206871753;4378.737275763465;4397.802098905557;4400.273954797487;4417.646588272931;5020.799168033311;5070.188769796815;5076.340075790124;5131.153359695683;5131.281620573122;1325.8607846176012;1342.2013901728455;1347.8921686265076;1349.8650134986424;1351.5674984005025;835.9634053773399;870.8737233101165;877.7542288159326;885.5572213893054;892.8660601036777;4353.172897149531;4513.323001549728;4517.2772356423475;4518.774061296922;4525.208088584484;5148.4079330876675;5179.559737422362;5199.480051994846;5237.350234676065;5280;4521.299198624219;4532.456105267389;4534.342520334533;4542.886427839265;4551.180787458289;2640.56430688938;2789.232960935759;2803.3972695870484;2803.453326601334;2810.522211224056;4884.389451318585;4920;4936.481669424658;4947;4948.331975183376;5079.622051335894;5310.468953104659;5338.813141540105;5364.249005139283;5394.514493695587;4898.020395920759;4912.298235970202;4919.2129259318335;4919.606431485544;4923.556879880828;5246.554042906396;5249.291345668286;5253.686578355411;5268.604854635841;5279.815206467755;5027.924581131359;5133;5187.19598462239;5197.674592978766;5198.038362902724;4877.609791216765;4895.608351331956;4909.361782968192;4931.48219436954;4942.456329803791;3804.6385593368586;3812.618738126276;3821.598732133086;3856.4381425521588;3857.7685338879755;5131.204663277049;5186.107070919163;5199.76601052946;5252.947470525246;5290.497402746733;5080.669756465818;5092.2361645753435;5095.388553373619;5110.463401342954;5115.4884511550035;5070.8225212117395;5093.643444958817;5123.769430375716;5141.794328226829;5144.279800827812;4807.278908163804;5061;5063.5695965843315;5067.974660126676;5075.670081444694;4924.261360795909;5038.445770965264;5124.308218390619;5175.896482070262;5179.585633149414;5006.949930500648;5014.774335154853;5029.4719054498755;5032.471590483093;5056.924146137884 03:56:00 INFO - PROCESS | 10120 | |5;yui.html;653.5621133840326;683.1290105115977;705.1186017478152;709.6841905352118;728.8775286059468;12417.627471175869;13533.323333833307;13562.932185339072;14600.926995365035;15205.23973801311;14455.421783128662;14479.13125212488;14604.269786510658;14612.342444589993;14618.926905365484;619.1888625900062;769.0924708843562;790.0598288037231;799.5842162075717;804;783.4789864739942;792.2473650032492;792.3661071143091;792.453207286973;793.9404544659145;835.4736515994945;840.6133178737788;841.6128580852815;841.7264389073545;841.8484672758901;640.3532432243468;804.8309854930413;826.8346330733877;834.4909605140859;835.7659855240543;606.7269728622138;608.6652341212316;608.9056196289538;609.0924522461545;610.2951091489336;13567.253801040939;13634.659133521642;13635.181889086587;13645.931770341183;13654.726905461934;11515;11940.88059119415;12109.15235933485;12379.257244565355;12410.56563020299;11144.554217831277;11298.322100673986;11476.598319058876;11502.367369794658;11986.580469683518;4175.645070169039;4206.579342065799;4283.336082907154;4354.368616550614;4400.273954797454;55476;57094.143587846214;57151.71424142894;57788;57806.7109664449;10179.338343007681;10209.74475638115;10235.897641023494;10240.743981400376;10329.328593641389;17496.5625859352;17924.283028678707;17924.641507169785;17944.820551794575;18007.18967646459;6744.83137921546;6804.795856124324;6814.829629259309;6855.245922948472;6920.688569014406;3854.807259637007;3937.665298449607;3979.3633018716864;4017.0961533654695;4071.7353372031316;2953.20263528846;3086.182161727144;3086.9536956945662;3087.6603573607335;3092.196029032468;508.1437777345185;529.7060131626984;553.8144721518256;565.9292588426447;568.2357229526281;452.558755213664;466.9066186762661;479.0227935012605;530.2841164427991;571.6570057965188;7489.213632568611;7597.506162099557;7755.978691490082;7762.7671169865;7926.524408535506;422.8308676529351;464.9442066951987;511.7850502788838;514.7143335448861;541.5423966748092;3288.5067239913724;3493.6855682988653;3578.499010138583;3619.5475565554307;3660.6136443762593;91194.54402727944;91884;92195;94144.0585594149;95119;80558.19441805624;82029.17970820334;83316.16683833205;84137.57931210304;84188.36963966918;62072.37927620756;68180.31819681938;70163.64918175376;70366;72740.63629681818;6964.094667693167;6985.196702379291;7100.964495177491;7197.388222000979;7348.081489813773;42304.78847605742;43309.78345108254;43493;44454.333185001604;44576.55423445724;53981.730091349295;62489.375106250176;63436;63892.68053659888;64288.678556606916;9580.712578622653;9758.951205243928;9830.557624906753;9991.450470224207;10418.843717344094;11098.778024439627;11191.2725672831;11232.943835280772;11462.083033357478;11861.288322700666;8476.449030812977;11295.435228238719;11629;12049.759004820029;12078.577249796215;11381.601643942422;11589.59436419755;11611.709707257387;11620.418979051183;12258.509659613872;10940.617078402218;11075.778484430428;11129.944350278196;11609.3614851184;11656.475458604553;8722.956385218033;8886.422382545114;9053.68312109073;9184.357095003286;9266.397684150508;9062.682806101755;9104.499252541174;9111.407758495676;9441.669541566012;9503.097205765442 03:56:00 INFO - PROCESS | 10120 | __end_tp_report 03:56:00 INFO - PROCESS | 10120 | __start_cc_report 03:56:00 INFO - PROCESS | 10120 | _x_x_mozilla_cycle_collect,1057 03:56:00 INFO - PROCESS | 10120 | __end_cc_report 03:56:00 INFO - PROCESS | 10120 | __startTimestamp1466765760896__endTimestamp 03:56:00 INFO - PROCESS | 10120 | 03:56:00 INFO - PROCESS | 10120 | ------- Summary: start ------- 03:56:00 INFO - PROCESS | 10120 | Number of tests: 6 03:56:00 INFO - PROCESS | 10120 | 03:56:00 INFO - PROCESS | 10120 | [#0] dojo.html Cycles:165 Average:4775.92 Median:4882.58 stddev:509.17 (10.4%) stddev-sans-first:483.14 03:56:00 INFO - PROCESS | 10120 | Values: 2668.2 2695.5 2715.5 2736.7 2739.4 4706.3 4767.5 4781.3 4894.2 4944.5 4722.4 4751.8 4758.3 4776.0 4780.9 4358.4 4420.1 4455.7 4484.9 4590.4 4515.1 4526.9 4539.5 4566.9 4580.2 4305.9 4348.2 4351.3 4425.9 4439.9 4428.3 4434.7 4440.5 4448.9 4530.0 4451.6 4455.9 4474.1 4501.8 4513.6 4721.9 4777.3 4874.0 4888.7 4933.5 5135.2 5240.2 5242.0 5242.4 5246.7 5223.0 5230.8 5245.7 5258.3 5281.8 4673.7 4776.6 4823.2 4873.5 4920.3 5327.1 5327.7 5331.4 5371.2 5374.7 5149.3 5159.4 5167.0 5170.2 5170.9 5054.4 5090.6 5119.5 5131.1 5246.7 5126.8 5135.9 5137.9 5166.1 5167.4 5119.7 5121.6 5137.1 5139.6 5190.9 4249.1 4266.8 4292.5 4336.6 4377.4 3734.3 3746.0 3753.0 3763.9 3817.9 4402.9 4436.0 4451.9 4491.8 4497.0 5039.8 5073.4 5094.7 5175.8 5232.2 4423.7 4453.7 4454.3 4486.2 4500.4 4633.8 4651.9 4654.6 4657.2 4699.2 4714.0 4767.1 4817.1 4864.0 4877.6 5143.0 5166.0 5167.0 5167.8 5198.1 4821.6 4832.0 4843.0 4844.8 4878.2 4991.4 5112.9 5117.1 5130.3 5176.2 5251.9 5257.9 5260.7 5275.1 5278.2 5121.3 5122.8 5124.2 5125.6 5126.5 4850.8 4924.8 4950.9 4972.1 5014.9 4902.2 4926.7 5003.1 5005.8 5013.5 4944.3 5064.8 5064.8 5069.8 5072.5 4830.7 4882.6 4895.5 4933.2 5011.6 03:56:00 INFO - PROCESS | 10120 | 03:56:00 INFO - PROCESS | 10120 | [#1] ext.html Cycles:180 Average:46360.06 Median:19170.72 stddev:81632.46 (425.8%) stddev-sans-first:81788.95 03:56:00 INFO - PROCESS | 10120 | Values: 535.6 576.6 579.4 580.5 628.0 26864.3 29611.3 29625.9 29710.3 38902.0 40305.4 40427.2 40637.6 40682.8 40713.4 7708.0 7862.4 7863.4 7866.7 7878.9 7478.4 7773.2 9997.1 10248.3 10271.2 10302.2 10356.2 10357.7 10364.4 10383.1 7517.1 10263.2 10294.7 10301.6 10317.8 9414.4 10140.2 10235.9 10638.9 10644.2 35883.1 36425.5 39720.4 39835.2 39842.0 3105.7 3128.2 3131.1 3169.2 3225.5 29505.4 29888.7 30247.2 30359.7 30894.8 3462.4 3561.0 3564.8 3577.7 3586.2 270778.3 271717.0 271905.0 271975.0 271983.6 57316.7 58259.4 58294.7 58305.4 58337.4 33762.8 34717.0 34780.5 37023.4 64018.7 13796.2 13930.7 13940.1 13955.2 13969.9 9131.5 10247.0 10620.8 10743.1 10753.9 19226.1 19291.7 19364.3 19365.4 19371.2 7132.3 7218.6 7224.6 7272.3 7450.1 764.5 876.2 993.7 1004.7 1046.9 27729.3 28520.0 28653.3 28868.4 28963.4 912.9 914.4 975.5 985.3 1059.8 14791.5 15103.2 15229.5 15242.5 15485.6 395446.0 398083.0 399233.0 399881.0 400707.0 50408.7 51059.5 51135.0 51155.2 51157.5 1069.8 1158.8 1194.1 1201.9 1214.4 27779.9 29192.7 29244.6 29272.9 29293.6 36566.8 36936.3 36967.6 37157.3 37230.0 237052.0 237722.0 238071.0 238251.0 238295.0 20536.7 39726.8 40114.2 40792.4 40858.2 43123.6 43644.8 43963.3 44268.8 44575.3 36667.3 37407.6 37516.0 37725.6 38018.2 37058.8 37413.6 38262.8 38322.8 38540.6 36399.5 36897.4 37324.4 37825.2 37878.0 32089.5 34006.5 34236.3 34407.7 34738.8 25513.5 25733.0 25881.5 25891.6 26038.2 03:56:00 INFO - PROCESS | 10120 | 03:56:00 INFO - PROCESS | 10120 | [#2] jquery.html Cycles:180 Average:24431.61 Median:5167.09 stddev:65107.66 (1260.0%) stddev-sans-first:65265.24 03:56:00 INFO - PROCESS | 10120 | Values: 367.4 367.8 370.9 376.7 390.9 15678.4 16693.0 17255.4 17269.6 17289.6 14665.8 15815.1 16033.1 16211.5 16485.3 4851.7 5047.9 5079.3 5087.6 5089.6 3677.2 3880.2 4960.7 5622.2 5973.4 5922.4 5933.4 5955.2 6011.1 6017.3 5678.5 5935.4 5937.3 5940.4 5945.9 3332.2 4913.5 5244.6 5249.7 5250.2 19074.4 19127.3 19147.2 19578.1 19648.9 1942.4 1948.3 1999.4 2008.2 2059.7 12647.5 12830.2 12900.9 12910.9 13481.6 1717.5 1720.5 1729.3 1731.2 1837.0 64366.4 66148.0 66225.0 67557.3 68079.3 9362.7 9426.0 9683.1 9780.4 9932.6 13440.4 13486.3 13530.6 13541.9 13554.1 7259.9 7388.5 7411.4 7416.4 7510.0 6967.7 7107.0 7110.1 7127.8 7128.3 6045.6 6118.7 6148.9 6208.6 6253.3 1535.5 1641.2 1715.6 1722.2 1724.7 842.7 863.4 863.5 917.7 948.5 16265.3 16399.8 16918.8 16984.9 17141.0 845.7 856.6 868.4 910.7 984.7 9037.7 9884.2 9939.0 10168.8 10170.1 388506.0 390635.0 391405.0 394246.0 404709.0 81262.2 81370.6 83211.0 83398.6 84725.1 888.7 909.7 921.8 923.9 924.5 15388.4 15754.7 15904.7 16129.0 16170.9 36231.6 37275.3 37278.6 38474.2 39177.6 47877.3 48490.0 48788.8 49015.8 55229.7 6502.8 7010.5 7253.2 7288.5 7307.9 10839.5 11570.5 11729.5 11789.4 11802.8 6965.4 7630.7 9698.2 9981.6 9995.3 4948.7 7892.7 9449.1 10357.4 10458.8 9378.2 9546.9 9793.6 9807.1 10088.2 7024.5 7053.7 7091.3 7103.5 7291.2 9016.9 9642.7 9745.5 9912.9 10182.3 03:56:00 INFO - PROCESS | 10120 | 03:56:00 INFO - PROCESS | 10120 | [#3] mootools.html Cycles:180 Average:5168.88 Median:5086.04 stddev:2950.53 (58.0%) stddev-sans-first:2943.87 03:56:00 INFO - PROCESS | 10120 | Values: 1219.4 1391.5 1422.5 1521.8 1727.2 7472.6 7834.6 7859.5 8080.8 8121.5 7828.1 7975.0 7985.9 7999.0 8005.0 1852.3 1915.0 1920.9 2203.8 2232.6 1935.7 2115.3 2184.9 2188.7 2207.6 2205.0 2211.3 2228.6 2229.9 2230.0 1817.7 2192.3 2196.8 2198.1 2200.2 2083.0 2135.5 2142.0 2153.1 2158.4 7999.5 8019.0 8047.2 8047.8 8059.6 4457.0 4566.5 4568.9 4572.1 4572.9 2817.5 2906.6 2929.2 2988.2 2991.0 893.7 911.4 946.8 957.2 961.9 10580.2 10662.9 10663.8 10681.7 10684.7 4103.8 4171.5 4244.1 4267.0 4277.0 8918.9 9027.3 9043.7 9068.3 9068.4 4476.3 4550.1 4554.7 4558.9 4560.1 3418.8 3739.2 4187.7 4189.7 4191.2 3583.7 3658.0 3726.6 3735.3 3745.3 1184.7 1207.0 1215.6 1221.9 1225.8 707.8 789.0 801.9 810.4 830.2 4956.8 5079.5 5114.5 5203.6 5340.7 407.4 885.0 889.8 890.6 907.4 3356.7 3386.1 3396.5 3438.4 3501.4 9724.2 9761.9 9801.4 9853.7 10019.5 9695.1 9701.8 9707.0 9798.0 9809.6 7321.4 7550.9 7575.0 7588.7 7601.4 4967.6 5081.4 5090.7 5232.9 5313.3 9057.4 9294.8 9304.0 9323.8 9329.3 9091.9 9333.6 9532.2 9544.8 9546.0 6822.6 7068.8 7148.7 7154.1 7154.5 7489.7 7495.9 7527.5 7534.2 7545.3 6370.0 6598.8 6638.6 6665.2 6788.2 6443.2 6470.1 6535.4 6540.0 6542.5 5976.1 6187.4 6231.7 6295.0 6306.2 4577.8 4607.8 4619.2 4658.2 4731.3 4797.6 4824.1 4835.7 4846.7 4931.9 03:56:00 INFO - PROCESS | 10120 | 03:56:00 INFO - PROCESS | 10120 | [#4] prototype.html Cycles:180 Average:4247.38 Median:4853.60 stddev:1218.68 (25.1%) stddev-sans-first:1185.63 03:56:00 INFO - PROCESS | 10120 | Values: 304.9 311.3 311.5 314.7 315.9 4828.1 4895.3 4910.8 4913.7 4934.8 4815.4 4817.8 4831.3 4844.0 4863.2 3615.9 3721.5 3740.9 3862.0 3903.9 3806.9 3841.7 3849.7 3868.7 3883.4 3654.5 3791.6 3803.9 3812.8 3813.1 3567.8 3771.6 3772.9 3783.5 3789.6 3379.3 3381.9 3385.1 3392.9 3411.4 4727.5 4741.3 4743.2 4753.9 4785.6 4268.0 4335.0 4337.0 4357.2 4368.5 5034.8 5047.3 5085.4 5112.9 5117.6 3715.5 3725.2 3731.2 3734.3 3745.8 5113.2 5288.5 5313.6 5337.7 5339.1 3771.9 3772.0 3785.5 3787.2 3814.4 3839.5 3851.1 3855.7 3866.3 3869.9 4294.8 4378.7 4397.8 4400.3 4417.6 5020.8 5070.2 5076.3 5131.2 5131.3 1325.9 1342.2 1347.9 1349.9 1351.6 836.0 870.9 877.8 885.6 892.9 4353.2 4513.3 4517.3 4518.8 4525.2 5148.4 5179.6 5199.5 5237.4 5280.0 4521.3 4532.5 4534.3 4542.9 4551.2 2640.6 2789.2 2803.4 2803.5 2810.5 4884.4 4920.0 4936.5 4947.0 4948.3 5079.6 5310.5 5338.8 5364.2 5394.5 4898.0 4912.3 4919.2 4919.6 4923.6 5246.6 5249.3 5253.7 5268.6 5279.8 5027.9 5133.0 5187.2 5197.7 5198.0 4877.6 4895.6 4909.4 4931.5 4942.5 3804.6 3812.6 3821.6 3856.4 3857.8 5131.2 5186.1 5199.8 5252.9 5290.5 5080.7 5092.2 5095.4 5110.5 5115.5 5070.8 5093.6 5123.8 5141.8 5144.3 4807.3 5061.0 5063.6 5068.0 5075.7 4924.3 5038.4 5124.3 5175.9 5179.6 5006.9 5014.8 5029.5 5032.5 5056.9 03:56:00 INFO - PROCESS | 10120 | 03:56:00 INFO - PROCESS | 10120 | [#5] yui.html Cycles:180 Average:17128.14 Median:27261.64 stddev:24183.39 (88.7%) stddev-sans-first:24219.59 03:56:00 INFO - PROCESS | 10120 | Values: 653.6 683.1 705.1 709.7 728.9 12417.6 13533.3 13562.9 14600.9 15205.2 14455.4 14479.1 14604.3 14612.3 14618.9 619.2 769.1 790.1 799.6 804.0 783.5 792.2 792.4 792.5 793.9 835.5 840.6 841.6 841.7 841.8 640.4 804.8 826.8 834.5 835.8 606.7 608.7 608.9 609.1 610.3 13567.3 13634.7 13635.2 13645.9 13654.7 11515.0 11940.9 12109.2 12379.3 12410.6 11144.6 11298.3 11476.6 11502.4 11986.6 4175.6 4206.6 4283.3 4354.4 4400.3 55476.0 57094.1 57151.7 57788.0 57806.7 10179.3 10209.7 10235.9 10240.7 10329.3 17496.6 17924.3 17924.6 17944.8 18007.2 6744.8 6804.8 6814.8 6855.2 6920.7 3854.8 3937.7 3979.4 4017.1 4071.7 2953.2 3086.2 3087.0 3087.7 3092.2 508.1 529.7 553.8 565.9 568.2 452.6 466.9 479.0 530.3 571.7 7489.2 7597.5 7756.0 7762.8 7926.5 422.8 464.9 511.8 514.7 541.5 3288.5 3493.7 3578.5 3619.5 3660.6 91194.5 91884.0 92195.0 94144.1 95119.0 80558.2 82029.2 83316.2 84137.6 84188.4 62072.4 68180.3 70163.6 70366.0 72740.6 6964.1 6985.2 7101.0 7197.4 7348.1 42304.8 43309.8 43493.0 44454.3 44576.6 53981.7 62489.4 63436.0 63892.7 64288.7 9580.7 9759.0 9830.6 9991.5 10418.8 11098.8 11191.3 11232.9 11462.1 11861.3 8476.4 11295.4 11629.0 12049.8 12078.6 11381.6 11589.6 11611.7 11620.4 12258.5 10940.6 11075.8 11129.9 11609.4 11656.5 8723.0 8886.4 9053.7 9184.4 9266.4 9062.7 9104.5 9111.4 9441.7 9503.1 03:56:00 INFO - PROCESS | 10120 | -------- Summary: end -------- 03:56:00 INFO - PROCESS | 10120 | 03:56:01 INFO - TEST-INFO | 10120: exit 0 03:56:01 INFO - TEST-OK | dromaeo_css | took 1119848ms 03:56:01 INFO - TEST-START | kraken 03:56:01 INFO - operating with platform_type : linux_ 03:56:01 INFO - Initialising browser for kraken test... 03:56:01 INFO - TEST-INFO | started process 10296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVSWBbD/profile http://localhost:57377/getInfo.html) 03:56:06 INFO - PROCESS | 10296 | __metrics Screen width/height:1600/1200 03:56:06 INFO - PROCESS | 10296 | colorDepth:24 03:56:06 INFO - PROCESS | 10296 | Browser inner width/height: 1024/697 03:56:06 INFO - PROCESS | 10296 | __metrics 03:56:07 INFO - PROCESS | 10296 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:56:07 INFO - TEST-INFO | 10296: exit 0 03:56:07 INFO - Browser initialized. 03:56:07 INFO - Running cycle 1/1 for kraken test... 03:56:07 INFO - TEST-INFO | started process 10381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVSWBbD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:20 INFO - PROCESS | 10381 | RSS: Main: 175190016 03:56:20 INFO - PROCESS | 10381 | 03:56:22 INFO - PROCESS | 10381 | Cycle 1(1): loaded http://localhost:57377/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57377/tests/kraken/driver.html?testName=audio-beat-detection) 03:56:23 INFO - PROCESS | 10381 | RSS: Main: 233631744 03:56:23 INFO - PROCESS | 10381 | 03:56:26 INFO - PROCESS | 10381 | Cycle 1(1): loaded http://localhost:57377/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57377/tests/kraken/driver.html?testName=audio-dft) 03:56:27 INFO - PROCESS | 10381 | RSS: Main: 222199808 03:56:27 INFO - PROCESS | 10381 | 03:56:30 INFO - PROCESS | 10381 | Cycle 1(1): loaded http://localhost:57377/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57377/tests/kraken/driver.html?testName=audio-fft) 03:56:31 INFO - PROCESS | 10381 | RSS: Main: 287854592 03:56:31 INFO - PROCESS | 10381 | 03:56:33 INFO - PROCESS | 10381 | Cycle 1(1): loaded http://localhost:57377/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57377/tests/kraken/driver.html?testName=audio-oscillator) 03:56:33 INFO - PROCESS | 10381 | RSS: Main: 198246400 03:56:33 INFO - PROCESS | 10381 | 03:56:36 INFO - PROCESS | 10381 | Cycle 1(1): loaded http://localhost:57377/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57377/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:56:36 INFO - PROCESS | 10381 | RSS: Main: 202027008 03:56:36 INFO - PROCESS | 10381 | 03:56:39 INFO - PROCESS | 10381 | Cycle 1(1): loaded http://localhost:57377/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57377/tests/kraken/driver.html?testName=imaging-darkroom) 03:56:40 INFO - PROCESS | 10381 | RSS: Main: 238530560 03:56:40 INFO - PROCESS | 10381 | 03:56:43 INFO - PROCESS | 10381 | Cycle 1(1): loaded http://localhost:57377/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57377/tests/kraken/driver.html?testName=imaging-desaturate) 03:56:44 INFO - PROCESS | 10381 | RSS: Main: 239214592 03:56:44 INFO - PROCESS | 10381 | 03:56:47 INFO - PROCESS | 10381 | Cycle 1(1): loaded http://localhost:57377/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57377/tests/kraken/driver.html?testName=json-parse-financial) 03:56:48 INFO - PROCESS | 10381 | RSS: Main: 238837760 03:56:48 INFO - PROCESS | 10381 | 03:56:49 INFO - PROCESS | 10381 | Cycle 1(1): loaded http://localhost:57377/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57377/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:56:50 INFO - PROCESS | 10381 | RSS: Main: 228184064 03:56:50 INFO - PROCESS | 10381 | 03:56:52 INFO - PROCESS | 10381 | Cycle 1(1): loaded http://localhost:57377/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57377/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:56:52 INFO - PROCESS | 10381 | RSS: Main: 232792064 03:56:52 INFO - PROCESS | 10381 | 03:56:55 INFO - PROCESS | 10381 | Cycle 1(1): loaded http://localhost:57377/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57377/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:56:55 INFO - PROCESS | 10381 | RSS: Main: 238407680 03:56:55 INFO - PROCESS | 10381 | 03:56:58 INFO - PROCESS | 10381 | Cycle 1(1): loaded http://localhost:57377/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:56:59 INFO - PROCESS | 10381 | RSS: Main: 242405376 03:56:59 INFO - PROCESS | 10381 | 03:57:02 INFO - PROCESS | 10381 | Cycle 1(1): loaded http://localhost:57377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:57:02 INFO - PROCESS | 10381 | RSS: Main: 240316416 03:57:02 INFO - PROCESS | 10381 | 03:57:04 INFO - PROCESS | 10381 | Cycle 1(1): loaded http://localhost:57377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57377/tests/kraken/driver.html?testName=ai-astar) 03:57:04 INFO - PROCESS | 10381 | RSS: Main: 284012544 03:57:04 INFO - PROCESS | 10381 | 03:57:04 INFO - PROCESS | 10381 | __start_tp_report 03:57:04 INFO - PROCESS | 10381 | _x_x_mozilla_page_load 03:57:04 INFO - PROCESS | 10381 | _x_x_mozilla_page_load_details 03:57:04 INFO - PROCESS | 10381 | |i|pagename|runs| 03:57:04 INFO - PROCESS | 10381 | |0;ai-astar;106;114;113;113;112;113;114;114;113;113 03:57:04 INFO - PROCESS | 10381 | |1;audio-beat-detection;158;133;138;202;133;161;159;140;206;131 03:57:04 INFO - PROCESS | 10381 | |2;audio-dft;162;162;161;161;162;162;163;163;161;162 03:57:04 INFO - PROCESS | 10381 | |3;audio-fft;75;76;75;122;75;76;76;76;100;75 03:57:04 INFO - PROCESS | 10381 | |4;audio-oscillator;86;86;113;86;86;87;121;87;85;133 03:57:04 INFO - PROCESS | 10381 | |5;imaging-gaussian-blur;117;118;118;117;118;117;118;117;117;118 03:57:04 INFO - PROCESS | 10381 | |6;imaging-darkroom;146;146;147;146;145;146;145;145;145;146 03:57:04 INFO - PROCESS | 10381 | |7;imaging-desaturate;96;95;96;96;95;96;95;96;96;96 03:57:04 INFO - PROCESS | 10381 | |8;json-parse-financial;64;65;64;63;67;64;64;64;65;66 03:57:04 INFO - PROCESS | 10381 | |9;json-stringify-tinderbox;65;65;65;65;66;65;66;65;66;66 03:57:04 INFO - PROCESS | 10381 | |10;stanford-crypto-aes;83;83;81;81;83;83;82;84;92;83 03:57:04 INFO - PROCESS | 10381 | |11;stanford-crypto-ccm;150;142;132;132;133;141;129;133;151;131 03:57:04 INFO - PROCESS | 10381 | |12;stanford-crypto-pbkdf2;169;171;172;168;173;171;174;168;173;167 03:57:04 INFO - PROCESS | 10381 | |13;stanford-crypto-sha256-iterative;69;68;69;68;67;66;67;67;66;66 03:57:04 INFO - PROCESS | 10381 | __end_tp_report 03:57:04 INFO - PROCESS | 10381 | __start_cc_report 03:57:04 INFO - PROCESS | 10381 | _x_x_mozilla_cycle_collect,1876 03:57:04 INFO - PROCESS | 10381 | __end_cc_report 03:57:04 INFO - PROCESS | 10381 | __startTimestamp1466765824683__endTimestamp 03:57:04 INFO - PROCESS | 10381 | 03:57:04 INFO - PROCESS | 10381 | ------- Summary: start ------- 03:57:04 INFO - PROCESS | 10381 | Number of tests: 14 03:57:04 INFO - PROCESS | 10381 | 03:57:04 INFO - PROCESS | 10381 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:2.37 (2.1%) stddev-sans-first:0.67 03:57:04 INFO - PROCESS | 10381 | Values: 106.0 114.0 113.0 113.0 112.0 113.0 114.0 114.0 113.0 113.0 03:57:04 INFO - PROCESS | 10381 | 03:57:04 INFO - PROCESS | 10381 | [#1] audio-beat-detection Cycles:10 Average:156.10 Median:158.50 stddev:27.72 (17.5%) stddev-sans-first:29.40 03:57:04 INFO - PROCESS | 10381 | Values: 158.0 133.0 138.0 202.0 133.0 161.0 159.0 140.0 206.0 131.0 03:57:04 INFO - PROCESS | 10381 | 03:57:04 INFO - PROCESS | 10381 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 03:57:04 INFO - PROCESS | 10381 | Values: 162.0 162.0 161.0 161.0 162.0 162.0 163.0 163.0 161.0 162.0 03:57:04 INFO - PROCESS | 10381 | 03:57:04 INFO - PROCESS | 10381 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.50 stddev:15.85 (21.0%) stddev-sans-first:16.57 03:57:04 INFO - PROCESS | 10381 | Values: 75.0 76.0 75.0 122.0 75.0 76.0 76.0 76.0 100.0 75.0 03:57:04 INFO - PROCESS | 10381 | 03:57:04 INFO - PROCESS | 10381 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:86.00 stddev:18.12 (21.1%) stddev-sans-first:18.78 03:57:04 INFO - PROCESS | 10381 | Values: 86.0 86.0 113.0 86.0 86.0 87.0 121.0 87.0 85.0 133.0 03:57:04 INFO - PROCESS | 10381 | 03:57:04 INFO - PROCESS | 10381 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 03:57:04 INFO - PROCESS | 10381 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 03:57:04 INFO - PROCESS | 10381 | 03:57:04 INFO - PROCESS | 10381 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 03:57:04 INFO - PROCESS | 10381 | Values: 146.0 146.0 147.0 146.0 145.0 146.0 145.0 145.0 145.0 146.0 03:57:04 INFO - PROCESS | 10381 | 03:57:04 INFO - PROCESS | 10381 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:57:04 INFO - PROCESS | 10381 | Values: 96.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 03:57:04 INFO - PROCESS | 10381 | 03:57:04 INFO - PROCESS | 10381 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.50 stddev:1.17 (1.8%) stddev-sans-first:1.22 03:57:04 INFO - PROCESS | 10381 | Values: 64.0 65.0 64.0 63.0 67.0 64.0 64.0 64.0 65.0 66.0 03:57:04 INFO - PROCESS | 10381 | 03:57:04 INFO - PROCESS | 10381 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 03:57:04 INFO - PROCESS | 10381 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 66.0 65.0 66.0 66.0 03:57:04 INFO - PROCESS | 10381 | 03:57:04 INFO - PROCESS | 10381 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.00 stddev:3.14 (3.8%) stddev-sans-first:3.32 03:57:04 INFO - PROCESS | 10381 | Values: 83.0 83.0 81.0 81.0 83.0 83.0 82.0 84.0 92.0 83.0 03:57:04 INFO - PROCESS | 10381 | 03:57:04 INFO - PROCESS | 10381 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:137.00 stddev:8.07 (5.9%) stddev-sans-first:7.16 03:57:04 INFO - PROCESS | 10381 | Values: 150.0 142.0 132.0 132.0 133.0 141.0 129.0 133.0 151.0 131.0 03:57:04 INFO - PROCESS | 10381 | 03:57:04 INFO - PROCESS | 10381 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:171.50 stddev:2.46 (1.4%) stddev-sans-first:2.54 03:57:04 INFO - PROCESS | 10381 | Values: 169.0 171.0 172.0 168.0 173.0 171.0 174.0 168.0 173.0 167.0 03:57:04 INFO - PROCESS | 10381 | 03:57:04 INFO - PROCESS | 10381 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.16 (1.7%) stddev-sans-first:1.05 03:57:04 INFO - PROCESS | 10381 | Values: 69.0 68.0 69.0 68.0 67.0 66.0 67.0 67.0 66.0 66.0 03:57:04 INFO - PROCESS | 10381 | -------- Summary: end -------- 03:57:04 INFO - PROCESS | 10381 | 03:57:05 INFO - TEST-INFO | 10381: exit 0 03:57:05 INFO - TEST-OK | kraken | took 64198ms 03:57:05 INFO - SUITE-END | took 1184s 03:57:05 INFO - Completed test suite (00:19:44) 03:57:05 INFO - javascript benchmark 03:57:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2668.1995401379586, 2695.5417579011564, 2715.5247831629467, 2736.657917760281, 2739.3973325868315, 4706.3411122442885, 4767.523247675235, 4781.258904869742, 4894.2413925841465, 4944.456109827916, 4722.3860898083285, 4751.786169622366, 4758.286257061434, 4776.044791041797, 4780.904381912368, 4358.43340365752, 4420.093880754438, 4455.732656040648, 4484.8878778030485, 4590.42619672541, 4515.05183911379, 4526.886827829314, 4539.477960034589, 4566.931496027546, 4580.1984652685815, 4305.935410968838, 4348.173846969065, 4351.325544540601, 4425.911481770347, 4439.88900277494, 4428.291473364278, 4434.667399945017, 4440.533743956903, 4448.888777780549, 4529.9547004530195, 4451.554844515555, 4455.910881782379, 4474.127545128701, 4501.7524036178, 4513.593776560093, 4721.905561888743, 4777.307290442901, 4874.049560335736, 4888.73111978841, 4933.45731969483, 5135.152699804527, 5240.187770895517, 5242.0, 5242.397124330712, 5246.685198888079, 5222.97388513055, 5230.843074707765, 5245.737713114329, 5258.2638430619745, 5281.815136470205, 4673.696209746356, 4776.641751868554, 4823.1800593898415, 4873.512648735169, 4920.335754673145, 5327.094393953037, 5327.653702509325, 5331.3868905076415, 5371.221172929982, 5374.731263436813, 5149.330587023663, 5159.432462429205, 5166.974165129151, 5170.1986192140275, 5170.948290517122, 5054.393472783289, 5090.643654944119, 5119.462456442095, 5131.102057139986, 5246.711430871263, 5126.820561280338, 5135.87160320995, 5137.871553211125, 5166.147585648326, 5167.431582525919, 5119.692818430906, 5121.61587880903, 5137.101007323703, 5139.614528910347, 5190.92213616796, 4249.128928569698, 4266.829326826892, 4292.484901811803, 4336.6313863321975, 4377.409049778239, 3734.3464893643504, 3745.9885830825524, 3753.042974041602, 3763.9435408468894, 3817.923641527154, 4402.911941761146, 4436.0, 4451.933221001687, 4491.752953587584, 4496.9881776600005, 5039.84880453587, 5073.365829271341, 5094.6688465249645, 5175.844724658191, 5232.189010703347, 4423.668224883147, 4453.710508816981, 4454.265046267395, 4486.214912390318, 4500.392447019676, 4633.7683115844075, 4651.86044418668, 4654.581087702123, 4657.208274593328, 4699.2481203007355, 4713.9764301178275, 4767.070421267819, 4817.108834865561, 4863.9513604864205, 4877.609791216623, 5142.97428512855, 5165.974170129276, 5167.044096842096, 5167.767450464663, 5198.116320225495, 4821.590164836029, 4831.95168048315, 4842.951570484391, 4844.8304309350415, 4878.243872199815, 4991.425986011655, 5112.872178195426, 5117.053345131163, 5130.307408499954, 5176.197689358156, 5251.868703282448, 5257.89484210306, 5260.684358938476, 5275.129603615361, 5278.181881808326, 5121.308623335802, 5122.846314610568, 5124.231365295086, 5125.5899528036925, 5126.487351264844, 4850.7574621269505, 4924.778384972613, 4950.925736113889, 4972.105021096238, 5014.924776128434, 4902.166631672553, 4926.729029903247, 5003.099442100457, 5005.849824505271, 5013.523715247045, 4944.258361245842, 5064.772085256246, 5064.82273120439, 5069.822556210515, 5072.4673909239, 4830.686005409637, 4882.584980276716, 4895.46149923501, 4933.210686290176, 5011.649184557046], "value": 4743.1071308513065, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.6217522483037, 576.5704550110167, 579.3887448741579, 580.4891695308128, 628.0077477585415, 26864.32839179019, 29611.259718507048, 29625.851870740644, 29710.25724356892, 38902.0, 40305.39541906866, 40427.19145617086, 40637.59362406375, 40682.7965860171, 40713.38929916046, 7708.036495438084, 7862.410319226053, 7863.37093032556, 7866.724664636738, 7878.881816772753, 7478.401727861785, 7773.183815699355, 9997.100260976511, 10248.282620216587, 10271.17830573556, 10302.22733295002, 10356.17150627948, 10357.741056473573, 10364.429956352398, 10383.117435018032, 7517.060367454068, 10263.230257730662, 10294.691159265234, 10301.639442619547, 10317.79364412715, 9414.43513389192, 10140.239482038876, 10235.948820255926, 10638.893611063868, 10644.201684873666, 35883.102922426886, 36425.453618195745, 39720.404193937116, 39835.20329593392, 39842.0, 3105.6894310568987, 3128.1553980425383, 3131.0763324819004, 3169.239382548195, 3225.5322978168033, 29505.409891802257, 29888.70111298881, 30247.243818904484, 30359.69640303591, 30894.845525772453, 3462.4286992646184, 3560.964390356089, 3564.7682900611376, 3577.713782897362, 3586.2468881534646, 270778.2922170773, 271717.0, 271905.0, 271975.0, 271983.6400818003, 57316.71341643265, 58259.4174058254, 58294.708526457944, 58305.416945830846, 58337.4166258332, 33762.83118584441, 34717.0, 34780.478292825625, 37023.444648330296, 64018.67990660017, 13796.172229666252, 13930.721385572231, 13940.093893896865, 13955.162690238618, 13969.930150349182, 9131.543422828965, 10247.0, 10620.787584248272, 10743.14054875608, 10753.892461075446, 19226.134823932956, 19291.710624340645, 19364.322248721226, 19365.4190374289, 19371.225150994083, 7132.322429369202, 7218.566885986857, 7224.602646854369, 7272.345488905918, 7450.0687414073245, 764.4801534956283, 876.2332958661171, 993.7217579077869, 1004.7136566078633, 1046.853440518328, 27729.306767330978, 28520.0, 28653.283667908054, 28868.42263154725, 28963.42073158525, 912.8539433690711, 914.3690853311194, 975.5171190260725, 985.3398223190479, 1059.761553650438, 14791.482298119729, 15103.169325686973, 15229.466968656045, 15242.542723718085, 15485.612859678598, 395446.0, 398083.0, 399233.0, 399881.0, 400707.0, 50408.747956259984, 51059.48940510547, 51135.0, 51155.232671509955, 51157.48842511527, 1069.769999450122, 1158.8377627132209, 1194.0865238092865, 1201.867794542617, 1214.4110106598293, 27779.86110069437, 29192.708072919, 29244.561331579618, 29272.853635731684, 29293.560596590643, 36566.817165914, 36936.26127477382, 36967.63032369749, 37157.25685486329, 37230.0, 237052.0, 237722.0, 238071.0, 238251.0, 238295.0, 20536.691949621065, 39726.80136599414, 40114.1977160461, 40792.3881141789, 40858.182836342516, 43123.56876431195, 43644.78177609092, 43963.34054989242, 44268.7786561078, 44575.33137002883, 36667.26665466622, 37407.6259237415, 37516.0, 37725.62274377221, 38018.2396352077, 37058.80882757263, 37413.625863741014, 38262.80868595639, 38322.80838595789, 38540.6145938537, 36399.47437582061, 36897.44653830141, 37324.440133398566, 37825.24349512939, 37878.0, 32089.518657220626, 34006.48990265099, 34236.31527369488, 34407.65592344045, 34738.82630586831, 25513.48973020492, 25733.0, 25881.482370352864, 25891.61162582525, 26038.218853434428], "value": 18015.913402276772, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.42497990644637, 367.8179301245884, 370.93137769512623, 376.6911132871046, 390.91986142840705, 15678.372865085397, 16693.0, 17255.396061137864, 17269.568260793487, 17289.567760805956, 14665.780013299782, 15815.130167840764, 16033.118178500177, 16211.51365459038, 16485.258163382645, 4851.708897466155, 5047.899042019158, 5079.3142925705115, 5087.56755675768, 5089.592832573404, 3677.191017976041, 3880.2239552089695, 4960.702357858522, 5622.184783206432, 5973.4026597340135, 5922.4373684500115, 5933.436323549277, 5955.1960485334575, 6011.128386383972, 6017.338092809788, 5678.4605462480995, 5935.406459354052, 5937.2578427696535, 5940.435658612425, 5945.940540594582, 3332.23358627517, 4913.484084171147, 5244.580433565306, 5249.658772179796, 5250.18622113573, 19074.427767167006, 19127.330543431053, 19147.234110635698, 19578.118984645724, 19648.90175549113, 1942.417274817563, 1948.3278268997174, 1999.380192140441, 2008.2167954497756, 2059.660156074246, 12647.49410023598, 12830.230186188764, 12900.935495322557, 12910.935445322808, 13481.59555213345, 1717.4933394648608, 1720.4838548435544, 1729.3342063305593, 1731.2469075952001, 1837.0263760207113, 64366.3563364365, 66148.0, 66225.0, 67557.3244267556, 68079.31920680829, 9362.719118426457, 9426.0, 9683.128518433376, 9780.41317520951, 9932.602695892083, 13440.395182216824, 13486.325683715775, 13530.594082177551, 13541.932290338485, 13554.118982266122, 7259.89110163348, 7388.519746216479, 7411.407087432993, 7416.40668746499, 7510.0, 6967.686454109577, 7106.964465177641, 7110.146782386147, 7127.786166415016, 7128.251533589002, 6045.6070355426755, 6118.724657390339, 6148.8770224595255, 6208.596441231396, 6253.280872699698, 1535.4702627593463, 1641.1876121320024, 1715.6054107555083, 1722.2336060453229, 1724.741288806689, 842.650300125441, 863.3869952333788, 863.4819108534955, 917.738444543302, 948.4783369147079, 16265.268062937197, 16399.83600163983, 16918.830811691972, 16984.915075424542, 17141.0, 845.6532821543137, 856.5931182688173, 868.392125512144, 910.6767097680228, 984.7095106943469, 9037.728868133834, 9884.159846413135, 9938.950305248572, 10168.796624067478, 10170.135538479164, 388506.0, 390635.0, 391405.0, 394246.0, 404709.0, 81262.18737812665, 81370.59314703388, 83211.0, 83398.58300708457, 84725.06924515225, 888.7467071884482, 909.7316291694099, 921.7511271956535, 923.9076092390842, 924.5192499900014, 15388.384464621737, 15754.684906302038, 15904.681906362039, 16129.0, 16170.919145404197, 36231.63768362282, 37275.25449491049, 37278.6272137286, 38474.230515388976, 39177.6082239174, 47877.28184077311, 48490.0, 48788.75605622091, 49015.75492122517, 55229.723851380484, 6502.804915852532, 7010.47421443404, 7253.165885923187, 7288.489805713549, 7307.890381644386, 10839.512221950188, 11570.537178512765, 11729.530818767154, 11789.410529473664, 11802.76394472123, 6965.407940325129, 7630.702780527435, 9698.224142068759, 9981.550830212513, 9995.300328976902, 4948.678335908155, 7892.723754668559, 9449.055094490495, 10357.4303413313, 10458.790824183627, 9378.249740020918, 9546.90453095488, 9793.608255669978, 9807.06832850878, 10088.243381746252, 7024.5434046786795, 7053.717851285891, 7091.255418181223, 7103.467239957127, 7291.234420385783, 9016.86474702893, 9642.662506812228, 9745.506815266755, 9912.900870991487, 10182.287239893136], "value": 8205.830528723482, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1219.3598360860542, 1391.4503771010452, 1422.5092343141614, 1521.8478152184782, 1727.1882215358785, 7472.589007604586, 7834.608269586526, 7859.489133206344, 8080.757577272677, 8121.512709237435, 7828.099768526621, 7975.0, 7985.92014079859, 7999.0, 8005.0, 1852.3239017758556, 1915.0, 1920.9039548022613, 2203.7796220377954, 2232.57581059599, 1935.7096435534643, 2115.3336698939784, 2184.8798316092607, 2188.6935828983956, 2207.624703800358, 2205.007746514067, 2211.292386436341, 2228.565429741193, 2229.9296337757887, 2229.9888500557477, 1817.7273408988626, 2192.2655910270078, 2196.758356580775, 2198.087793565668, 2200.2409168836807, 2082.9687554686693, 2135.519508110678, 2142.046789178816, 2153.052656831005, 2158.3848603148026, 7999.520028798291, 8019.037715474122, 8047.23551262635, 8047.798805029863, 8059.63731632078, 4457.0, 4566.4520257568975, 4568.862934111949, 4572.1312950539295, 4572.9314060289125, 2817.4646817104685, 2906.593076969226, 2929.2383980165096, 2988.2379993101836, 2991.0428662827903, 893.7452825944574, 911.4121391702381, 946.7822400847774, 957.1911734584265, 961.9422834629945, 10580.206484513692, 10662.946685266601, 10663.786724265548, 10681.679549613524, 10684.679459616224, 4103.753774773463, 4171.457710497616, 4244.066305412866, 4267.039916018933, 4276.978615106905, 8918.866217006751, 9027.322950778718, 9043.728688139367, 9068.274538036942, 9068.410553314014, 4476.283794592915, 4550.135474259946, 4554.681172317906, 4558.88602784933, 4560.087982403466, 3418.8119653418803, 3739.1960728443514, 4187.66498680111, 4189.748615083044, 4191.161767646483, 3583.749137560346, 3657.9817100914856, 3726.64596863303, 3735.34631439497, 3745.250949810049, 1184.6564496295978, 1206.9879301207052, 1215.5927764198916, 1221.9369148840565, 1225.7977433723513, 707.8230442389403, 788.9960550197212, 801.8773716796532, 810.3719617296642, 830.1781236575747, 4956.776945037482, 5079.547253443085, 5114.514121158559, 5203.557697595671, 5340.706261155596, 407.4234957535114, 884.9557522123997, 889.7953470701775, 890.5680744838749, 907.4237858959608, 3356.697897189216, 3386.102682789063, 3396.524486571882, 3438.415469370213, 3501.439769636846, 9724.17344525709, 9761.9023809761, 9801.411915284963, 9853.704388868346, 10019.549120289605, 9695.127438530426, 9701.805963880824, 9706.951465242628, 9798.0, 9809.607615695435, 7321.414286857039, 7550.886736698954, 7574.99999999989, 7588.734394296173, 7601.391888648895, 4967.620867989684, 5081.364829396325, 5090.720010399464, 5232.869178270574, 5313.309269794902, 9057.365984381293, 9294.767630809283, 9303.976562577976, 9323.813523729352, 9329.346945713734, 9091.909080909107, 9333.579988900652, 9532.23742100644, 9544.761380965532, 9545.952270238604, 6822.624755638488, 7068.82327941785, 7148.714051437884, 7154.105736782903, 7154.534955227893, 7489.737859174903, 7495.850082998419, 7527.510711803715, 7534.246575342422, 7545.283198096172, 6369.9681501592195, 6598.802035938929, 6638.5684930479365, 6665.2334981475815, 6788.151481064867, 6443.162388889415, 6470.061841033118, 6535.44448721864, 6539.967300163468, 6542.476601871934, 5976.073708575178, 6187.381261873777, 6231.657258850807, 6295.0, 6306.180196574416, 4577.793999269974, 4607.792649330721, 4619.191641462798, 4658.208104622155, 4731.337612734151, 4797.571254518962, 4824.131656301899, 4835.734034628129, 4846.733429661262, 4931.926021109614], "value": 4126.962048080364, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.8780487804878, 311.3042350346974, 311.48915778123876, 314.7183270972481, 315.8689144005238, 4828.130936431441, 4895.265710143472, 4910.779014944327, 4913.729744864036, 4934.827281045164, 4815.446223684277, 4817.783199756011, 4831.347768051312, 4843.9757801211035, 4863.221884498472, 3615.8734444294455, 3721.51620289362, 3740.9438858417147, 3861.9806900965455, 3903.882883513499, 3806.885793426202, 3841.7118716096265, 3849.6727778138893, 3868.6711629511524, 3883.3786594144945, 3654.543182102237, 3791.5829258781514, 3803.923921521568, 3812.8474861005666, 3813.0657988792786, 3567.839447224881, 3771.622837716234, 3772.9434058489146, 3783.527059117624, 3789.621037896216, 3379.3241351729507, 3381.9492707609406, 3385.1367901185286, 3392.8982130536124, 3411.385950528904, 4727.5272472752795, 4741.2651039089, 4743.193657078305, 4753.928691069636, 4785.593224575915, 4267.95435118398, 4334.956650433487, 4336.956630433687, 4357.150355680644, 4368.541303163154, 5034.773435195389, 5047.268146118792, 5085.364329458817, 5112.872178195537, 5117.590592752571, 3715.498407714951, 3725.1990821973136, 3731.1791405890663, 3734.3278209922205, 3745.75652582584, 5113.2330150477355, 5288.524032837063, 5313.57491400687, 5337.653052551572, 5339.145736682151, 3771.9245615088093, 3771.962280377216, 3785.545734511821, 3787.223619158066, 3814.3515602347666, 3839.500864887603, 3851.114243723959, 3855.6505223171666, 3866.284737323604, 3869.877735456686, 4294.828206871753, 4378.737275763465, 4397.802098905557, 4400.273954797487, 4417.646588272931, 5020.799168033311, 5070.188769796815, 5076.340075790124, 5131.153359695683, 5131.281620573122, 1325.8607846176012, 1342.2013901728455, 1347.8921686265076, 1349.8650134986424, 1351.5674984005025, 835.9634053773399, 870.8737233101165, 877.7542288159326, 885.5572213893054, 892.8660601036777, 4353.172897149531, 4513.323001549728, 4517.2772356423475, 4518.774061296922, 4525.208088584484, 5148.4079330876675, 5179.559737422362, 5199.480051994846, 5237.350234676065, 5280.0, 4521.299198624219, 4532.456105267389, 4534.342520334533, 4542.886427839265, 4551.180787458289, 2640.56430688938, 2789.232960935759, 2803.3972695870484, 2803.453326601334, 2810.522211224056, 4884.389451318585, 4920.0, 4936.481669424658, 4947.0, 4948.331975183376, 5079.622051335894, 5310.468953104659, 5338.813141540105, 5364.249005139283, 5394.514493695587, 4898.020395920759, 4912.298235970202, 4919.2129259318335, 4919.606431485544, 4923.556879880828, 5246.554042906396, 5249.291345668286, 5253.686578355411, 5268.604854635841, 5279.815206467755, 5027.924581131359, 5133.0, 5187.19598462239, 5197.674592978766, 5198.038362902724, 4877.609791216765, 4895.608351331956, 4909.361782968192, 4931.48219436954, 4942.456329803791, 3804.6385593368586, 3812.618738126276, 3821.598732133086, 3856.4381425521588, 3857.7685338879755, 5131.204663277049, 5186.107070919163, 5199.76601052946, 5252.947470525246, 5290.497402746733, 5080.669756465818, 5092.2361645753435, 5095.388553373619, 5110.463401342954, 5115.4884511550035, 5070.8225212117395, 5093.643444958817, 5123.769430375716, 5141.794328226829, 5144.279800827812, 4807.278908163804, 5061.0, 5063.5695965843315, 5067.974660126676, 5075.670081444694, 4924.261360795909, 5038.445770965264, 5124.308218390619, 5175.896482070262, 5179.585633149414, 5006.949930500648, 5014.774335154853, 5029.4719054498755, 5032.471590483093, 5056.924146137884], "value": 3863.147573294721, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.5621133840326, 683.1290105115977, 705.1186017478152, 709.6841905352118, 728.8775286059468, 12417.627471175869, 13533.323333833307, 13562.932185339072, 14600.926995365035, 15205.23973801311, 14455.421783128662, 14479.13125212488, 14604.269786510658, 14612.342444589993, 14618.926905365484, 619.1888625900062, 769.0924708843562, 790.0598288037231, 799.5842162075717, 804.0, 783.4789864739942, 792.2473650032492, 792.3661071143091, 792.453207286973, 793.9404544659145, 835.4736515994945, 840.6133178737788, 841.6128580852815, 841.7264389073545, 841.8484672758901, 640.3532432243468, 804.8309854930413, 826.8346330733877, 834.4909605140859, 835.7659855240543, 606.7269728622138, 608.6652341212316, 608.9056196289538, 609.0924522461545, 610.2951091489336, 13567.253801040939, 13634.659133521642, 13635.181889086587, 13645.931770341183, 13654.726905461934, 11515.0, 11940.88059119415, 12109.15235933485, 12379.257244565355, 12410.56563020299, 11144.554217831277, 11298.322100673986, 11476.598319058876, 11502.367369794658, 11986.580469683518, 4175.645070169039, 4206.579342065799, 4283.336082907154, 4354.368616550614, 4400.273954797454, 55476.0, 57094.143587846214, 57151.71424142894, 57788.0, 57806.7109664449, 10179.338343007681, 10209.74475638115, 10235.897641023494, 10240.743981400376, 10329.328593641389, 17496.5625859352, 17924.283028678707, 17924.641507169785, 17944.820551794575, 18007.18967646459, 6744.83137921546, 6804.795856124324, 6814.829629259309, 6855.245922948472, 6920.688569014406, 3854.807259637007, 3937.665298449607, 3979.3633018716864, 4017.0961533654695, 4071.7353372031316, 2953.20263528846, 3086.182161727144, 3086.9536956945662, 3087.6603573607335, 3092.196029032468, 508.1437777345185, 529.7060131626984, 553.8144721518256, 565.9292588426447, 568.2357229526281, 452.558755213664, 466.9066186762661, 479.0227935012605, 530.2841164427991, 571.6570057965188, 7489.213632568611, 7597.506162099557, 7755.978691490082, 7762.7671169865, 7926.524408535506, 422.8308676529351, 464.9442066951987, 511.7850502788838, 514.7143335448861, 541.5423966748092, 3288.5067239913724, 3493.6855682988653, 3578.499010138583, 3619.5475565554307, 3660.6136443762593, 91194.54402727944, 91884.0, 92195.0, 94144.0585594149, 95119.0, 80558.19441805624, 82029.17970820334, 83316.16683833205, 84137.57931210304, 84188.36963966918, 62072.37927620756, 68180.31819681938, 70163.64918175376, 70366.0, 72740.63629681818, 6964.094667693167, 6985.196702379291, 7100.964495177491, 7197.388222000979, 7348.081489813773, 42304.78847605742, 43309.78345108254, 43493.0, 44454.333185001604, 44576.55423445724, 53981.730091349295, 62489.375106250176, 63436.0, 63892.68053659888, 64288.678556606916, 9580.712578622653, 9758.951205243928, 9830.557624906753, 9991.450470224207, 10418.843717344094, 11098.778024439627, 11191.2725672831, 11232.943835280772, 11462.083033357478, 11861.288322700666, 8476.449030812977, 11295.435228238719, 11629.0, 12049.759004820029, 12078.577249796215, 11381.601643942422, 11589.59436419755, 11611.709707257387, 11620.418979051183, 12258.509659613872, 10940.617078402218, 11075.778484430428, 11129.944350278196, 11609.3614851184, 11656.475458604553, 8722.956385218033, 8886.422382545114, 9053.68312109073, 9184.357095003286, 9266.397684150508, 9062.682806101755, 9104.499252541174, 9111.407758495676, 9441.669541566012, 9503.097205765442], "value": 6426.120042857878, "unit": "score"}], "name": "dromaeo_css", "value": 6447.658210562374, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 113.0, 113.0, 112.0, 113.0, 114.0, 114.0, 113.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 133.0, 138.0, 202.0, 133.0, 161.0, 159.0, 140.0, 206.0, 131.0], "value": 156.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 162.0, 162.0, 163.0, 163.0, 161.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 122.0, 75.0, 76.0, 76.0, 76.0, 100.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 113.0, 86.0, 86.0, 87.0, 121.0, 87.0, 85.0, 133.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 63.0, 67.0, 64.0, 64.0, 64.0, 65.0, 66.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 81.0, 81.0, 83.0, 83.0, 82.0, 84.0, 92.0, 83.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 142.0, 132.0, 132.0, 133.0, 141.0, 129.0, 133.0, 151.0, 131.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 172.0, 168.0, 173.0, 171.0, 174.0, 168.0, 173.0, 167.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 68.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1557.8, "alertThreshold": 2.0}]} 03:57:05 INFO - Return code: 0 03:57:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:57:05 INFO - # TBPL SUCCESS # 03:57:05 INFO - Running post-action listener: _resource_record_post_action 03:57:05 INFO - ##### 03:57:05 INFO - ##### Finished run-tests step (success) 03:57:05 INFO - ##### 03:57:05 INFO - Running post-run listener: _resource_record_post_run 03:57:06 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 364113920; Read time: 0; Write time: 235900 03:57:06 INFO - TinderboxPrint: CPU usage
13.1% 03:57:06 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:57:06 INFO - TinderboxPrint: I/O write bytes / time
364,113,920 / 235,900 03:57:06 INFO - TinderboxPrint: CPU idle
8,323.7 (86.8%) 03:57:06 INFO - TinderboxPrint: CPU user
1,214.3 (12.7%) 03:57:06 INFO - TinderboxPrint: Swap in / out
0 / 0 03:57:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 75292672; Read time: 0; Write time: 39604 03:57:06 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 288821248; Read time: 0; Write time: 196296 03:57:06 INFO - Running post-run listener: _upload_blobber_files 03:57:06 INFO - Blob upload gear active. 03:57:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:57:06 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 03:57:06 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:57:06 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:57:07 INFO - (blobuploader) - INFO - Open directory for files ... 03:57:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:57:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:57:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:07 INFO - (blobuploader) - INFO - Done attempting. 03:57:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:57:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:57:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:08 INFO - (blobuploader) - INFO - Done attempting. 03:57:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:57:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:57:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:13 INFO - (blobuploader) - INFO - Done attempting. 03:57:13 INFO - (blobuploader) - INFO - Iteration through files over. 03:57:13 INFO - Return code: 0 03:57:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:57:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:57:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48d02ada03f58b6dccd46fbf735e997dd6e1768b91ff6d80f4685a57033bab0ade45a63ae80471d3a1d78d442465b7c14d8ce50b3514caec6621cad1cd683b39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99052b5e7054e2085585c6d2afcc4071508b3be981d98c6a85e2afef0b5b0ffd8ea1d2f20c30ce0f3e574bae438279674cc6725260fa6f9d07ef36f467e7104e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bb3bba8ebfc103b3863996a43e028b20e3930e63bccce9e9b940d7217c54b6ab9e90c653b04643d491b9e750ea83f2ca6ba040bccd1d06cc79a0d96fb9a779b"} 03:57:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:57:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:57:13 INFO - Contents: 03:57:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48d02ada03f58b6dccd46fbf735e997dd6e1768b91ff6d80f4685a57033bab0ade45a63ae80471d3a1d78d442465b7c14d8ce50b3514caec6621cad1cd683b39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99052b5e7054e2085585c6d2afcc4071508b3be981d98c6a85e2afef0b5b0ffd8ea1d2f20c30ce0f3e574bae438279674cc6725260fa6f9d07ef36f467e7104e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bb3bba8ebfc103b3863996a43e028b20e3930e63bccce9e9b940d7217c54b6ab9e90c653b04643d491b9e750ea83f2ca6ba040bccd1d06cc79a0d96fb9a779b"} 03:57:13 INFO - Running post-run listener: copy_logs_to_upload_dir 03:57:13 INFO - Copying logs to upload dir... 03:57:13 INFO - mkdir: /builds/slave/test/build/upload/logs 03:57:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.136903 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-24 03:57:13.166804) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 03:57:13.170463) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48d02ada03f58b6dccd46fbf735e997dd6e1768b91ff6d80f4685a57033bab0ade45a63ae80471d3a1d78d442465b7c14d8ce50b3514caec6621cad1cd683b39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99052b5e7054e2085585c6d2afcc4071508b3be981d98c6a85e2afef0b5b0ffd8ea1d2f20c30ce0f3e574bae438279674cc6725260fa6f9d07ef36f467e7104e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bb3bba8ebfc103b3863996a43e028b20e3930e63bccce9e9b940d7217c54b6ab9e90c653b04643d491b9e750ea83f2ca6ba040bccd1d06cc79a0d96fb9a779b"} build_url:https://queue.taskcluster.net/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011170 build_url: 'https://queue.taskcluster.net/v1/task/GyAIC98xQPeyxgImE1iYSg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48d02ada03f58b6dccd46fbf735e997dd6e1768b91ff6d80f4685a57033bab0ade45a63ae80471d3a1d78d442465b7c14d8ce50b3514caec6621cad1cd683b39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99052b5e7054e2085585c6d2afcc4071508b3be981d98c6a85e2afef0b5b0ffd8ea1d2f20c30ce0f3e574bae438279674cc6725260fa6f9d07ef36f467e7104e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bb3bba8ebfc103b3863996a43e028b20e3930e63bccce9e9b940d7217c54b6ab9e90c653b04643d491b9e750ea83f2ca6ba040bccd1d06cc79a0d96fb9a779b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 03:57:13.196638) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:57:13.196978) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466764575.42954-1426907240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:57:13.280004) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 03:57:13.280352) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 03:57:13.280653) ========= ========= Total master_lag: 0.18 =========