builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-014 starttime: 1466778130.06 results: success (0) buildid: 20160624065159 builduid: 0cf1320950514f9db3e16e879867b52c revision: bfc23df4f226dda14cabd0937bef12919471c480 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 07:22:10.062026) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 07:22:10.062509) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 07:22:10.062789) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 07:22:10.078051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 07:22:10.078477) ========= 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=31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 07:22:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 211M=0s 2016-06-24 07:22:11 (211 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070684 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 07:22:10.163044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 07:22:10.163375) ========= 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=31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015789 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 07:22:10.213214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 07:22:10.213590) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bfc23df4f226dda14cabd0937bef12919471c480 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev bfc23df4f226dda14cabd0937bef12919471c480 --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=31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 07:22:11,261 truncating revision to first 12 chars 2016-06-24 07:22:11,261 Setting DEBUG logging. 2016-06-24 07:22:11,261 attempt 1/10 2016-06-24 07:22:11,261 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bfc23df4f226?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 07:22:11,770 unpacking tar archive at: fx-team-bfc23df4f226/testing/mozharness/ program finished with exit code 0 elapsedTime=0.850544 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 07:22:11.078188) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 07:22:11.078523) ========= script_repo_revision: bfc23df4f226dda14cabd0937bef12919471c480 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 07:22:11.078914) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 07:22:11.079181) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 07:22:11.087578) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-24 07:22:11.087916) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:22:12 INFO - MultiFileLogger online at 20160624 07:22:12 in /builds/slave/test 07:22:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:22:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:22:12 INFO - {'append_to_log': False, 07:22:12 INFO - 'base_work_dir': '/builds/slave/test', 07:22:12 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:22:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:22:12 INFO - 'branch': 'Fx-Team-Non-PGO', 07:22:12 INFO - 'buildbot_json_path': 'buildprops.json', 07:22:12 INFO - 'config_files': ('talos/linux_config.py',), 07:22:12 INFO - 'default_actions': ('clobber', 07:22:12 INFO - 'read-buildbot-config', 07:22:12 INFO - 'download-and-extract', 07:22:12 INFO - 'populate-webroot', 07:22:12 INFO - 'create-virtualenv', 07:22:12 INFO - 'install', 07:22:12 INFO - 'run-tests'), 07:22:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:22:12 INFO - 'download_minidump_stackwalk': True, 07:22:12 INFO - 'download_symbols': 'ondemand', 07:22:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:22:12 INFO - 'tooltool.py': '/tools/tooltool.py', 07:22:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:22:12 INFO - '/tools/misc-python/virtualenv.py')}, 07:22:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:22:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:22:12 INFO - 'installer_path': 'installer.exe', 07:22:12 INFO - 'log_level': 'info', 07:22:12 INFO - 'log_name': 'talos', 07:22:12 INFO - 'log_to_console': True, 07:22:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:22:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:22:12 INFO - 'opt_config_files': (), 07:22:12 INFO - 'pip_index': False, 07:22:12 INFO - 'sps_profile': False, 07:22:12 INFO - 'sps_profile_interval': 0, 07:22:12 INFO - 'suite': 'dromaeojs-e10s', 07:22:12 INFO - 'system_bits': '32', 07:22:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:22:12 INFO - 'title': 'talos-linux64-ix-014', 07:22:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:22:12 INFO - 'use_talos_json': True, 07:22:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:22:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:22:12 INFO - 'work_dir': 'build'} 07:22:12 INFO - ##### 07:22:12 INFO - ##### Running clobber step. 07:22:12 INFO - ##### 07:22:12 INFO - Running pre-action listener: _resource_record_pre_action 07:22:12 INFO - Running main action method: clobber 07:22:12 INFO - rmtree: /builds/slave/test/build 07:22:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:22:12 INFO - Running post-action listener: _resource_record_post_action 07:22:12 INFO - ##### 07:22:12 INFO - ##### Finished clobber step (success) 07:22:12 INFO - ##### 07:22:12 INFO - ##### 07:22:12 INFO - ##### Running read-buildbot-config step. 07:22:12 INFO - ##### 07:22:12 INFO - Running pre-action listener: _resource_record_pre_action 07:22:12 INFO - Running main action method: read_buildbot_config 07:22:12 INFO - Using buildbot properties: 07:22:12 INFO - { 07:22:12 INFO - "project": "", 07:22:12 INFO - "product": "firefox", 07:22:12 INFO - "script_repo_revision": "production", 07:22:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:22:12 INFO - "repository": "", 07:22:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:22:12 INFO - "buildid": "20160624065159", 07:22:12 INFO - "pgo_build": "False", 07:22:12 INFO - "basedir": "/builds/slave/test", 07:22:12 INFO - "buildnumber": 1428, 07:22:12 INFO - "slavename": "talos-linux64-ix-014", 07:22:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:22:12 INFO - "platform": "ubuntu64_hw", 07:22:12 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:22:12 INFO - "branch": "fx-team", 07:22:12 INFO - "repo_path": "integration/fx-team", 07:22:12 INFO - "revision": "bfc23df4f226dda14cabd0937bef12919471c480", 07:22:12 INFO - "stage_platform": "linux64", 07:22:12 INFO - "builduid": "0cf1320950514f9db3e16e879867b52c", 07:22:12 INFO - "slavebuilddir": "test" 07:22:12 INFO - } 07:22:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:22:12 INFO - Running post-action listener: _resource_record_post_action 07:22:12 INFO - ##### 07:22:12 INFO - ##### Finished read-buildbot-config step (success) 07:22:12 INFO - ##### 07:22:12 INFO - ##### 07:22:12 INFO - ##### Running download-and-extract step. 07:22:12 INFO - ##### 07:22:12 INFO - Running pre-action listener: _resource_record_pre_action 07:22:12 INFO - Running main action method: download_and_extract 07:22:12 INFO - mkdir: /builds/slave/test/build/tests 07:22:12 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')]} 07:22:12 INFO - https://queue.taskcluster.net/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:22:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:22:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:22:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/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 07:22:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/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 07:22:13 INFO - Downloaded 1361 bytes. 07:22:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:22:13 INFO - Using the following test package requirements: 07:22:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:22:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:22:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:22:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:13 INFO - u'jsshell-linux-x86_64.zip'], 07:22:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:22:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:22:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:22:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:22:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:22:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:22:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:13 INFO - https://queue.taskcluster.net/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:22:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:22:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:22:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/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 07:22:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/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 07:22:14 INFO - Downloaded 22710890 bytes. 07:22:14 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'] 07:22:14 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 07:22:15 INFO - Return code: 0 07:22:15 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 07:22:15 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')]} 07:22:15 INFO - https://queue.taskcluster.net/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:22:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:22:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:22:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/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 07:22:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/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 07:22:16 INFO - Downloaded 22710890 bytes. 07:22:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:22:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:22:18 INFO - Return code: 0 07:22: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')]} 07:22:18 INFO - https://queue.taskcluster.net/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:22:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:22:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:22:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/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 07:22:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/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 07:22:19 INFO - Downloaded 14405518 bytes. 07:22:19 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'] 07:22:19 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 07:22:19 INFO - Return code: 0 07:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:19 INFO - https://queue.taskcluster.net/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:22:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:22:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:22:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/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 07:22:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P326_xjBRzOgN_2tVc84Ug/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 07:22:20 INFO - Downloaded 56264936 bytes. 07:22:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:22:20 INFO - mkdir: /builds/slave/test/properties 07:22:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:22:20 INFO - Writing to file /builds/slave/test/properties/build_url 07:22:20 INFO - Contents: 07:22:20 INFO - build_url:https://queue.taskcluster.net/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:22:21 INFO - Running post-action listener: _resource_record_post_action 07:22:21 INFO - Running post-action listener: set_extra_try_arguments 07:22:21 INFO - ##### 07:22:21 INFO - ##### Finished download-and-extract step (success) 07:22:21 INFO - ##### 07:22:21 INFO - ##### 07:22:21 INFO - ##### Running populate-webroot step. 07:22:21 INFO - ##### 07:22:21 INFO - Running pre-action listener: _resource_record_pre_action 07:22:21 INFO - Running main action method: populate_webroot 07:22:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:22:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:22:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:22:21 INFO - '--tppagecycles', 07:22:21 INFO - '7'], 07:22:21 INFO - 'tests': ['tsvgm']}}, 07:22:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:22:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:22:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:22:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:22:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:22:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:22:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:21 INFO - 'talos_options': ['--disable-e10s'], 07:22:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:22:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:22:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:21 INFO - 'talos_options': ['--disable-e10s'], 07:22:21 INFO - 'tests': ['damp', 'tps']}, 07:22:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:21 INFO - 'tests': ['damp', 'tps']}, 07:22:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:22:21 INFO - 'tests': ['dromaeo_dom']}, 07:22:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:22:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:22:21 INFO - 'tests': ['basic_compositor_video']}, 07:22:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:22:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:22:21 INFO - 'tests': ['a11yr', 07:22:21 INFO - 'ts_paint', 07:22:21 INFO - 'tpaint', 07:22:21 INFO - 'sessionrestore', 07:22:21 INFO - 'sessionrestore_no_auto_restore', 07:22:21 INFO - 'tabpaint']}, 07:22:21 INFO - 'other-e10s': {'tests': ['a11yr', 07:22:21 INFO - 'ts_paint', 07:22:21 INFO - 'tpaint', 07:22:21 INFO - 'sessionrestore', 07:22:21 INFO - 'sessionrestore_no_auto_restore', 07:22:21 INFO - 'tabpaint']}, 07:22:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:22:21 INFO - 'ts_paint', 07:22:21 INFO - 'tpaint', 07:22:21 INFO - 'sessionrestore', 07:22:21 INFO - 'sessionrestore_no_auto_restore', 07:22:21 INFO - 'tabpaint']}, 07:22:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:22:21 INFO - 'ts_paint', 07:22:21 INFO - 'tpaint', 07:22:21 INFO - 'sessionrestore', 07:22:21 INFO - 'sessionrestore_no_auto_restore', 07:22:21 INFO - 'tabpaint']}, 07:22:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:22:21 INFO - 'tests': ['a11yr', 07:22:21 INFO - 'ts_paint', 07:22:21 INFO - 'tpaint', 07:22:21 INFO - 'sessionrestore', 07:22:21 INFO - 'sessionrestore_no_auto_restore', 07:22:21 INFO - 'tabpaint']}, 07:22:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:22:21 INFO - 'tests': ['a11yr', 07:22:21 INFO - 'ts_paint', 07:22:21 INFO - 'tpaint', 07:22:21 INFO - 'sessionrestore', 07:22:21 INFO - 'sessionrestore_no_auto_restore', 07:22:21 INFO - 'tabpaint']}, 07:22:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:22:21 INFO - 'tests': ['tsvgx', 07:22:21 INFO - 'tsvgr_opacity', 07:22:21 INFO - 'tart', 07:22:21 INFO - 'tscrollx', 07:22:21 INFO - 'cart']}, 07:22:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:22:21 INFO - 'tsvgr_opacity', 07:22:21 INFO - 'tart', 07:22:21 INFO - 'tscrollx', 07:22:21 INFO - 'cart']}, 07:22:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:21 INFO - 'talos_options': ['--disable-e10s'], 07:22:21 INFO - 'tests': ['tp5o']}, 07:22:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:21 INFO - 'tests': ['tp5o']}, 07:22:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:21 INFO - 'talos_options': ['--disable-e10s', 07:22:21 INFO - '--xperf_path', 07:22:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:22:21 INFO - 'tests': ['tp5n']}, 07:22:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:21 INFO - 'talos_options': ['--xperf_path', 07:22:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:22:21 INFO - 'tests': ['tp5n']}}, 07:22:21 INFO - 'talos.zip': {'path': '', 07:22:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:22:21 INFO - Running post-action listener: _resource_record_post_action 07:22:21 INFO - ##### 07:22:21 INFO - ##### Finished populate-webroot step (success) 07:22:21 INFO - ##### 07:22:21 INFO - ##### 07:22:21 INFO - ##### Running create-virtualenv step. 07:22:21 INFO - ##### 07:22:21 INFO - Running pre-action listener: _resource_record_pre_action 07:22:21 INFO - Running main action method: create_virtualenv 07:22:21 INFO - Creating virtualenv /builds/slave/test/build/venv 07:22:21 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 07:22:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:22:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:22:21 INFO - Using real prefix '/usr' 07:22:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:22:22 INFO - Installing distribute.............................................................................................................................................................................................done. 07:22:24 INFO - Installing pip.................done. 07:22:24 INFO - Return code: 0 07:22:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:22:24 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')]} 07:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:24 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')]} 07:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:24 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 0x7fa56dd7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be22e0>, '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 0x1b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', '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 07:22:24 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 07:22:24 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 07:22:24 INFO - Using env: {'DISPLAY': ':0', 07:22:24 INFO - 'HOME': '/home/cltbld', 07:22:24 INFO - 'LANG': 'en_US.UTF-8', 07:22:24 INFO - 'LANGUAGE': 'en_US:en', 07:22:24 INFO - 'LOGNAME': 'cltbld', 07:22:24 INFO - 'MAIL': '/var/mail/cltbld', 07:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:24 INFO - 'MOZ_NO_REMOTE': '1', 07:22:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:24 INFO - 'NO_EM_RESTART': '1', 07:22:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:24 INFO - 'PWD': '/builds/slave/test', 07:22:24 INFO - 'SHELL': '/bin/bash', 07:22:24 INFO - 'SHLVL': '1', 07:22:24 INFO - 'TERM': 'linux', 07:22:24 INFO - 'TMOUT': '86400', 07:22:24 INFO - 'USER': 'cltbld', 07:22:24 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', 07:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:24 INFO - '_': '/tools/buildbot/bin/python'} 07:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:24 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 07:22:24 INFO - Cleaning up... 07:22:24 INFO - Return code: 0 07:22:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:22:24 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')]} 07:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:24 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')]} 07:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:24 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 0x7fa56dd7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be22e0>, '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 0x1b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', '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 07:22:24 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 07:22:24 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 07:22:24 INFO - Using env: {'DISPLAY': ':0', 07:22:24 INFO - 'HOME': '/home/cltbld', 07:22:24 INFO - 'LANG': 'en_US.UTF-8', 07:22:24 INFO - 'LANGUAGE': 'en_US:en', 07:22:24 INFO - 'LOGNAME': 'cltbld', 07:22:24 INFO - 'MAIL': '/var/mail/cltbld', 07:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:24 INFO - 'MOZ_NO_REMOTE': '1', 07:22:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:24 INFO - 'NO_EM_RESTART': '1', 07:22:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:24 INFO - 'PWD': '/builds/slave/test', 07:22:24 INFO - 'SHELL': '/bin/bash', 07:22:24 INFO - 'SHLVL': '1', 07:22:24 INFO - 'TERM': 'linux', 07:22:24 INFO - 'TMOUT': '86400', 07:22:24 INFO - 'USER': 'cltbld', 07:22:24 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', 07:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:24 INFO - '_': '/tools/buildbot/bin/python'} 07:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:24 INFO - Downloading/unpacking psutil>=3.1.1 07:22:24 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 07:22:24 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 07:22:24 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 07:22:24 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 07:22:24 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 07:22:24 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 07:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:22:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:22:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:22:26 INFO - Installing collected packages: psutil 07:22:26 INFO - Running setup.py install for psutil 07:22:26 INFO - building 'psutil._psutil_linux' extension 07:22:26 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 07:22:26 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 07:22:26 INFO - building 'psutil._psutil_posix' extension 07:22:26 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 07:22:26 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 07:22:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:22:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:22:27 INFO - Successfully installed psutil 07:22:27 INFO - Cleaning up... 07:22:27 INFO - Return code: 0 07:22:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:22:27 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')]} 07:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:27 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')]} 07:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:27 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 0x7fa56dd7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be22e0>, '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 0x1b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', '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 07:22:27 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 07:22:27 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 07:22:27 INFO - Using env: {'DISPLAY': ':0', 07:22:27 INFO - 'HOME': '/home/cltbld', 07:22:27 INFO - 'LANG': 'en_US.UTF-8', 07:22:27 INFO - 'LANGUAGE': 'en_US:en', 07:22:27 INFO - 'LOGNAME': 'cltbld', 07:22:27 INFO - 'MAIL': '/var/mail/cltbld', 07:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:27 INFO - 'MOZ_NO_REMOTE': '1', 07:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:27 INFO - 'NO_EM_RESTART': '1', 07:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:27 INFO - 'PWD': '/builds/slave/test', 07:22:27 INFO - 'SHELL': '/bin/bash', 07:22:27 INFO - 'SHLVL': '1', 07:22:27 INFO - 'TERM': 'linux', 07:22:27 INFO - 'TMOUT': '86400', 07:22:27 INFO - 'USER': 'cltbld', 07:22:27 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', 07:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:27 INFO - '_': '/tools/buildbot/bin/python'} 07:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:22:27 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 07:22:27 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 07:22:27 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 07:22:27 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 07:22:27 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 07:22:27 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 07:22:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:22:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:22:29 INFO - Installing collected packages: mozsystemmonitor 07:22:29 INFO - Running setup.py install for mozsystemmonitor 07:22:29 INFO - Successfully installed mozsystemmonitor 07:22:29 INFO - Cleaning up... 07:22:29 INFO - Return code: 0 07:22:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:22: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')]} 07:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22: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')]} 07:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:29 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 0x7fa56dd7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be22e0>, '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 0x1b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', '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 07:22:29 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 07:22:29 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 07:22:29 INFO - Using env: {'DISPLAY': ':0', 07:22:29 INFO - 'HOME': '/home/cltbld', 07:22:29 INFO - 'LANG': 'en_US.UTF-8', 07:22:29 INFO - 'LANGUAGE': 'en_US:en', 07:22:29 INFO - 'LOGNAME': 'cltbld', 07:22:29 INFO - 'MAIL': '/var/mail/cltbld', 07:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:29 INFO - 'MOZ_NO_REMOTE': '1', 07:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:29 INFO - 'NO_EM_RESTART': '1', 07:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:29 INFO - 'PWD': '/builds/slave/test', 07:22:29 INFO - 'SHELL': '/bin/bash', 07:22:29 INFO - 'SHLVL': '1', 07:22:29 INFO - 'TERM': 'linux', 07:22:29 INFO - 'TMOUT': '86400', 07:22:29 INFO - 'USER': 'cltbld', 07:22:29 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', 07:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:29 INFO - '_': '/tools/buildbot/bin/python'} 07:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:29 INFO - Downloading/unpacking jsonschema==2.5.1 07:22:29 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 07:22:29 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 07:22:29 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 07:22:29 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 07:22:29 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 07:22:29 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 07:22:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:22:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:22:31 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 07:22:31 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 07:22:31 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 07:22:31 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 07:22:31 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 07:22:31 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 07:22:31 INFO - Downloading functools32-3.2.3-2.tar.gz 07:22:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:22:31 INFO - warning: no files found matching '*.txt' 07:22:31 INFO - no previously-included directories found matching 'build' 07:22:31 INFO - no previously-included directories found matching 'dist' 07:22:31 INFO - no previously-included directories found matching '.git*' 07:22:31 INFO - Installing collected packages: jsonschema, functools32 07:22:31 INFO - Running setup.py install for functools32 07:22:31 INFO - warning: no files found matching '*.txt' 07:22:31 INFO - no previously-included directories found matching 'build' 07:22:31 INFO - no previously-included directories found matching 'dist' 07:22:31 INFO - no previously-included directories found matching '.git*' 07:22:31 INFO - Successfully installed jsonschema functools32 07:22:31 INFO - Cleaning up... 07:22:31 INFO - Return code: 0 07:22:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:22: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')]} 07:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22: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')]} 07:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:31 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 0x7fa56dd7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be22e0>, '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 0x1b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', '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 07:22:31 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 07:22:31 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 07:22:31 INFO - Using env: {'DISPLAY': ':0', 07:22:31 INFO - 'HOME': '/home/cltbld', 07:22:31 INFO - 'LANG': 'en_US.UTF-8', 07:22:31 INFO - 'LANGUAGE': 'en_US:en', 07:22:31 INFO - 'LOGNAME': 'cltbld', 07:22:31 INFO - 'MAIL': '/var/mail/cltbld', 07:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:31 INFO - 'MOZ_NO_REMOTE': '1', 07:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:31 INFO - 'NO_EM_RESTART': '1', 07:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:31 INFO - 'PWD': '/builds/slave/test', 07:22:31 INFO - 'SHELL': '/bin/bash', 07:22:31 INFO - 'SHLVL': '1', 07:22:31 INFO - 'TERM': 'linux', 07:22:31 INFO - 'TMOUT': '86400', 07:22:31 INFO - 'USER': 'cltbld', 07:22:31 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', 07:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:31 INFO - '_': '/tools/buildbot/bin/python'} 07:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:32 INFO - Downloading/unpacking blobuploader==1.2.4 07:22:32 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 07:22:32 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 07:22:32 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 07:22:32 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 07:22:32 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 07:22:32 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 07:22:34 INFO - Downloading blobuploader-1.2.4.tar.gz 07:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:22:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:22:34 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 07:22:34 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 07:22:34 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 07:22:34 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 07:22:34 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 07:22:34 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 07:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:22:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:22:34 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 07:22:34 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 07:22:34 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 07:22:34 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 07:22:34 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 07:22:34 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 07:22:34 INFO - Downloading docopt-0.6.1.tar.gz 07:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:22:34 INFO - Installing collected packages: blobuploader, requests, docopt 07:22:34 INFO - Running setup.py install for blobuploader 07:22:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:22:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:22:34 INFO - Running setup.py install for requests 07:22:35 INFO - Running setup.py install for docopt 07:22:35 INFO - Successfully installed blobuploader requests docopt 07:22:35 INFO - Cleaning up... 07:22:35 INFO - Return code: 0 07:22:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:35 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 0x7fa56dd7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be22e0>, '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 0x1b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', '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 07:22:35 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 07:22:35 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 07:22:35 INFO - Using env: {'DISPLAY': ':0', 07:22:35 INFO - 'HOME': '/home/cltbld', 07:22:35 INFO - 'LANG': 'en_US.UTF-8', 07:22:35 INFO - 'LANGUAGE': 'en_US:en', 07:22:35 INFO - 'LOGNAME': 'cltbld', 07:22:35 INFO - 'MAIL': '/var/mail/cltbld', 07:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:35 INFO - 'MOZ_NO_REMOTE': '1', 07:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:35 INFO - 'NO_EM_RESTART': '1', 07:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:35 INFO - 'PWD': '/builds/slave/test', 07:22:35 INFO - 'SHELL': '/bin/bash', 07:22:35 INFO - 'SHLVL': '1', 07:22:35 INFO - 'TERM': 'linux', 07:22:35 INFO - 'TMOUT': '86400', 07:22:35 INFO - 'USER': 'cltbld', 07:22:35 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', 07:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:35 INFO - '_': '/tools/buildbot/bin/python'} 07:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:22:35 INFO - Running setup.py (path:/tmp/pip-xWKe_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:22:35 INFO - Running setup.py (path:/tmp/pip-bxaImQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:22:35 INFO - Running setup.py (path:/tmp/pip-1qdNl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:22:35 INFO - Running setup.py (path:/tmp/pip-ObPTuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:22:35 INFO - Running setup.py (path:/tmp/pip-tDRjXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:22:36 INFO - Running setup.py (path:/tmp/pip-KZbqDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:22:36 INFO - Running setup.py (path:/tmp/pip-psYsAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:22:36 INFO - Running setup.py (path:/tmp/pip-SjzuZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:22:36 INFO - Running setup.py (path:/tmp/pip-sWKn_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:22:36 INFO - Running setup.py (path:/tmp/pip-6A8Rsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:22:36 INFO - Running setup.py (path:/tmp/pip-0_t3dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:22:36 INFO - Running setup.py (path:/tmp/pip-1Gx7iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:22:36 INFO - Running setup.py (path:/tmp/pip-a7YZUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:22:36 INFO - Running setup.py (path:/tmp/pip-YHSY0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:36 INFO - Running setup.py (path:/tmp/pip-mOFypQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:22:36 INFO - Running setup.py (path:/tmp/pip-UP1ahU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:22:36 INFO - Running setup.py (path:/tmp/pip-tAmWGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:22:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:22:36 INFO - Running setup.py install for manifestparser 07:22:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:22:37 INFO - Running setup.py install for mozcrash 07:22:37 INFO - Running setup.py install for mozdebug 07:22:37 INFO - Running setup.py install for mozdevice 07:22:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:22:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:22:37 INFO - Running setup.py install for mozfile 07:22:37 INFO - Running setup.py install for mozhttpd 07:22:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:22:37 INFO - Running setup.py install for mozinfo 07:22:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:22:37 INFO - Running setup.py install for mozInstall 07:22:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:22:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:22:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:22:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:22:37 INFO - Running setup.py install for mozleak 07:22:37 INFO - Running setup.py install for mozlog 07:22:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:22:37 INFO - Running setup.py install for moznetwork 07:22:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:22:38 INFO - Running setup.py install for mozprocess 07:22:38 INFO - Running setup.py install for mozprofile 07:22:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:22:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:22:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:22:38 INFO - Running setup.py install for mozrunner 07:22:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:22:38 INFO - Running setup.py install for mozscreenshot 07:22:38 INFO - Running setup.py install for moztest 07:22:38 INFO - Running setup.py install for mozversion 07:22:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:22:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:22:38 INFO - Cleaning up... 07:22:38 INFO - Return code: 0 07:22:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:38 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 0x7fa56dd7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be22e0>, '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 0x1b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', '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 07:22:38 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 07:22:38 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 07:22:38 INFO - Using env: {'DISPLAY': ':0', 07:22:38 INFO - 'HOME': '/home/cltbld', 07:22:38 INFO - 'LANG': 'en_US.UTF-8', 07:22:38 INFO - 'LANGUAGE': 'en_US:en', 07:22:38 INFO - 'LOGNAME': 'cltbld', 07:22:38 INFO - 'MAIL': '/var/mail/cltbld', 07:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:38 INFO - 'MOZ_NO_REMOTE': '1', 07:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:38 INFO - 'NO_EM_RESTART': '1', 07:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:38 INFO - 'PWD': '/builds/slave/test', 07:22:38 INFO - 'SHELL': '/bin/bash', 07:22:38 INFO - 'SHLVL': '1', 07:22:38 INFO - 'TERM': 'linux', 07:22:38 INFO - 'TMOUT': '86400', 07:22:38 INFO - 'USER': 'cltbld', 07:22:38 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', 07:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:38 INFO - '_': '/tools/buildbot/bin/python'} 07:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:22:38 INFO - Running setup.py (path:/tmp/pip-NqV1GG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:22:38 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)) 07:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:22:39 INFO - Running setup.py (path:/tmp/pip-dOwAiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:22:39 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)) 07:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:22:39 INFO - Running setup.py (path:/tmp/pip-MNExmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:22:39 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)) 07:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:22:39 INFO - Running setup.py (path:/tmp/pip-EvD7lV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:22:39 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)) 07:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:22:39 INFO - Running setup.py (path:/tmp/pip-XjACTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:22:39 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)) 07:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:22:39 INFO - Running setup.py (path:/tmp/pip-85CRcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:22:39 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)) 07:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:22:39 INFO - Running setup.py (path:/tmp/pip-dpjJ0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:22:39 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)) 07:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:22:39 INFO - Running setup.py (path:/tmp/pip-xD7uVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:22:39 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)) 07:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:22:39 INFO - Running setup.py (path:/tmp/pip-SIAr8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:22:39 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)) 07:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:22:39 INFO - Running setup.py (path:/tmp/pip-8ioqQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:22:39 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)) 07:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:22:39 INFO - Running setup.py (path:/tmp/pip-LuAhS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:22:39 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)) 07:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:22:39 INFO - Running setup.py (path:/tmp/pip-k900KY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:22:39 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)) 07:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:22:39 INFO - Running setup.py (path:/tmp/pip-FxH121-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:22:39 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)) 07:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:22:39 INFO - Running setup.py (path:/tmp/pip-6PXCe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:22:39 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)) 07:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:39 INFO - Running setup.py (path:/tmp/pip-buIXAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:40 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)) 07:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:22:40 INFO - Running setup.py (path:/tmp/pip-qvXUgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:22:40 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)) 07:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:22:40 INFO - Running setup.py (path:/tmp/pip-9cOjL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:22:40 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)) 07:22:40 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)) 07:22:40 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)) 07:22:40 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)) 07:22:40 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)) 07:22:40 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)) 07:22:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:43 INFO - Downloading blessings-1.6.tar.gz 07:22:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:22:43 INFO - Installing collected packages: blessings 07:22:43 INFO - Running setup.py install for blessings 07:22:43 INFO - Successfully installed blessings 07:22:43 INFO - Cleaning up... 07:22:43 INFO - Return code: 0 07:22:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:22:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:22:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:22:43 INFO - Reading from file tmpfile_stdout 07:22:43 INFO - Current package versions: 07:22:43 INFO - argparse == 1.2.1 07:22:43 INFO - blessings == 1.6 07:22:43 INFO - blobuploader == 1.2.4 07:22:43 INFO - docopt == 0.6.1 07:22:43 INFO - functools32 == 3.2.3-2 07:22:43 INFO - jsonschema == 2.5.1 07:22:43 INFO - manifestparser == 1.1 07:22:43 INFO - mozInstall == 1.12 07:22:43 INFO - mozcrash == 0.17 07:22:43 INFO - mozdebug == 0.1 07:22:43 INFO - mozdevice == 0.48 07:22:43 INFO - mozfile == 1.2 07:22:43 INFO - mozhttpd == 0.7 07:22:43 INFO - mozinfo == 0.9 07:22:43 INFO - mozleak == 0.1 07:22:43 INFO - mozlog == 3.2 07:22:43 INFO - moznetwork == 0.27 07:22:43 INFO - mozprocess == 0.22 07:22:43 INFO - mozprofile == 0.28 07:22:43 INFO - mozrunner == 6.11 07:22:43 INFO - mozscreenshot == 0.1 07:22:43 INFO - mozsystemmonitor == 0.3 07:22:43 INFO - moztest == 0.7 07:22:43 INFO - mozversion == 1.4 07:22:43 INFO - psutil == 3.1.1 07:22:43 INFO - requests == 1.2.3 07:22:43 INFO - wsgiref == 0.1.2 07:22:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:43 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 0x7fa56dd7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be22e0>, '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 0x1b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', '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 07:22:43 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 07:22:43 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 07:22:43 INFO - Using env: {'DISPLAY': ':0', 07:22:43 INFO - 'HOME': '/home/cltbld', 07:22:43 INFO - 'LANG': 'en_US.UTF-8', 07:22:43 INFO - 'LANGUAGE': 'en_US:en', 07:22:43 INFO - 'LOGNAME': 'cltbld', 07:22:43 INFO - 'MAIL': '/var/mail/cltbld', 07:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:43 INFO - 'MOZ_NO_REMOTE': '1', 07:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:43 INFO - 'NO_EM_RESTART': '1', 07:22:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:43 INFO - 'PWD': '/builds/slave/test', 07:22:43 INFO - 'SHELL': '/bin/bash', 07:22:43 INFO - 'SHLVL': '1', 07:22:43 INFO - 'TERM': 'linux', 07:22:43 INFO - 'TMOUT': '86400', 07:22:43 INFO - 'USER': 'cltbld', 07:22:43 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', 07:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:43 INFO - '_': '/tools/buildbot/bin/python'} 07:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:43 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)) 07:22:43 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)) 07:22:43 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)) 07:22:43 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)) 07:22:43 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)) 07:22:43 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)) 07:22:43 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)) 07:22:43 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)) 07:22:43 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)) 07:22:43 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)) 07:22:43 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)) 07:22:43 INFO - Cleaning up... 07:22:43 INFO - Return code: 0 07:22:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa56dd7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be22e0>, '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 0x1b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', '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 07:22:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:22:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:22:43 INFO - Using env: {'DISPLAY': ':0', 07:22:43 INFO - 'HOME': '/home/cltbld', 07:22:43 INFO - 'LANG': 'en_US.UTF-8', 07:22:43 INFO - 'LANGUAGE': 'en_US:en', 07:22:43 INFO - 'LOGNAME': 'cltbld', 07:22:43 INFO - 'MAIL': '/var/mail/cltbld', 07:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:43 INFO - 'MOZ_NO_REMOTE': '1', 07:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:43 INFO - 'NO_EM_RESTART': '1', 07:22:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:43 INFO - 'PWD': '/builds/slave/test', 07:22:43 INFO - 'SHELL': '/bin/bash', 07:22:43 INFO - 'SHLVL': '1', 07:22:43 INFO - 'TERM': 'linux', 07:22:43 INFO - 'TMOUT': '86400', 07:22:43 INFO - 'USER': 'cltbld', 07:22:43 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', 07:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:43 INFO - '_': '/tools/buildbot/bin/python'} 07:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:22:43 INFO - Cleaning up... 07:22:43 INFO - Return code: 0 07:22:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa56dd7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be22e0>, '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 0x1b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e5d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', '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 07:22:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:22:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:22:43 INFO - Using env: {'DISPLAY': ':0', 07:22:43 INFO - 'HOME': '/home/cltbld', 07:22:43 INFO - 'LANG': 'en_US.UTF-8', 07:22:43 INFO - 'LANGUAGE': 'en_US:en', 07:22:43 INFO - 'LOGNAME': 'cltbld', 07:22:43 INFO - 'MAIL': '/var/mail/cltbld', 07:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:43 INFO - 'MOZ_NO_REMOTE': '1', 07:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:43 INFO - 'NO_EM_RESTART': '1', 07:22:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:43 INFO - 'PWD': '/builds/slave/test', 07:22:43 INFO - 'SHELL': '/bin/bash', 07:22:43 INFO - 'SHLVL': '1', 07:22:43 INFO - 'TERM': 'linux', 07:22:43 INFO - 'TMOUT': '86400', 07:22:43 INFO - 'USER': 'cltbld', 07:22:43 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', 07:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:43 INFO - '_': '/tools/buildbot/bin/python'} 07:22:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:44 INFO - Downloading/unpacking flake8 07:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:22:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:22:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:22:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:22:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:22:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:22:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:22:46 INFO - no previously-included directories found matching 'docs/_build' 07:22:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:22:46 INFO - Running setup.py install for pep8 07:22:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:22:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:22:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:22:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:22:46 INFO - no previously-included directories found matching 'docs/_build' 07:22:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:22:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:22:46 INFO - Cleaning up... 07:22:47 INFO - Return code: 0 07:22:47 INFO - Running post-action listener: _resource_record_post_action 07:22:47 INFO - Running post-action listener: _start_resource_monitoring 07:22:47 INFO - Starting resource monitoring. 07:22:47 INFO - ##### 07:22:47 INFO - ##### Finished create-virtualenv step (success) 07:22:47 INFO - ##### 07:22:47 INFO - ##### 07:22:47 INFO - ##### Running install step. 07:22:47 INFO - ##### 07:22:47 INFO - Running pre-action listener: _resource_record_pre_action 07:22:47 INFO - Running main action method: install 07:22:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:22:47 INFO - Reading from file tmpfile_stdout 07:22:47 INFO - Detecting whether we're running mozinstall >=1.0... 07:22:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:22:47 INFO - Reading from file tmpfile_stdout 07:22:47 INFO - Output received: 07:22:47 INFO - Usage: mozinstall [options] installer 07:22:47 INFO - Options: 07:22:47 INFO - -h, --help show this help message and exit 07:22:47 INFO - -d DEST, --destination=DEST 07:22:47 INFO - Directory to install application into. [default: 07:22:47 INFO - "/builds/slave/test"] 07:22:47 INFO - --app=APP Application being installed. [default: firefox] 07:22:47 INFO - mkdir: /builds/slave/test/build/application 07:22:47 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'] 07:22:47 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 07:23:03 INFO - Reading from file tmpfile_stdout 07:23:03 INFO - Output received: 07:23:03 INFO - /builds/slave/test/build/application/firefox/firefox 07:23:03 INFO - Running post-action listener: _resource_record_post_action 07:23:03 INFO - ##### 07:23:03 INFO - ##### Finished install step (success) 07:23:03 INFO - ##### 07:23:03 INFO - ##### 07:23:03 INFO - ##### Running run-tests step. 07:23:03 INFO - ##### 07:23:03 INFO - Running pre-action listener: _resource_record_pre_action 07:23:03 INFO - Running main action method: run_tests 07:23:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:23:03 INFO - Python 2.7.3 07:23:03 INFO - Return code: 0 07:23:03 INFO - grabbing minidump binary from tooltool 07:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:23:03 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 0x1be22e0>, '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 0x1b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b4e5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:23:03 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 07:23:03 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 07:23:03 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 07:23:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:23:03 INFO - Return code: 0 07:23:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:23:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:23:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:23:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:23:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:23:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:23:04 INFO - Return code: 0 07:23:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:23:04 INFO - Using env: {'DISPLAY': ':0', 07:23:04 INFO - 'HOME': '/home/cltbld', 07:23:04 INFO - 'LANG': 'en_US.UTF-8', 07:23:04 INFO - 'LANGUAGE': 'en_US:en', 07:23:04 INFO - 'LOGNAME': 'cltbld', 07:23:04 INFO - 'MAIL': '/var/mail/cltbld', 07:23:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:23:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:04 INFO - 'MOZ_NO_REMOTE': '1', 07:23:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:04 INFO - 'NO_EM_RESTART': '1', 07:23:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:04 INFO - 'PWD': '/builds/slave/test', 07:23:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:23:04 INFO - 'SHELL': '/bin/bash', 07:23:04 INFO - 'SHLVL': '1', 07:23:04 INFO - 'TERM': 'linux', 07:23:04 INFO - 'TMOUT': '86400', 07:23:04 INFO - 'USER': 'cltbld', 07:23:04 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826', 07:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:04 INFO - '_': '/tools/buildbot/bin/python'} 07:23:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:23:04 INFO - mozversion application_buildid: 20160624065159 07:23:04 INFO - mozversion application_changeset: bfc23df4f226dda14cabd0937bef12919471c480 07:23:04 INFO - mozversion application_display_name: Nightly 07:23:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:23:04 INFO - mozversion application_name: Firefox 07:23:04 INFO - mozversion application_remotingname: firefox 07:23:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:23:04 INFO - mozversion application_vendor: Mozilla 07:23:04 INFO - mozversion application_version: 50.0a1 07:23:04 INFO - mozversion platform_buildid: 20160624065159 07:23:04 INFO - mozversion platform_changeset: bfc23df4f226dda14cabd0937bef12919471c480 07:23:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:23:04 INFO - mozversion platform_version: 50.0a1 07:23:04 INFO - using testdate: 1466778184 07:23:04 INFO - actual date: 1466778184 07:23:04 INFO - starting webserver on 'localhost:34817' 07:23:04 INFO - SUITE-START | Running 2 tests 07:23:04 INFO - TEST-START | dromaeo_css 07:23:04 INFO - operating with platform_type : linux_ 07:23:04 INFO - Initialising browser for dromaeo_css test... 07:23:04 INFO - TEST-INFO | started process 22188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVaEVBn/profile http://localhost:34817/getInfo.html) 07:23:09 INFO - PROCESS | 22188 | __metrics Screen width/height:1600/1200 07:23:09 INFO - PROCESS | 22188 | colorDepth:24 07:23:09 INFO - PROCESS | 22188 | Browser inner width/height: 1024/697 07:23:09 INFO - PROCESS | 22188 | __metrics 07:23:10 ERROR - PROCESS | 22188 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:23:11 INFO - TEST-INFO | 22188: exit 0 07:23:11 INFO - Browser initialized. 07:23:11 INFO - Running cycle 1/1 for dromaeo_css test... 07:23:11 INFO - TEST-INFO | started process 22306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVaEVBn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:23:23 INFO - PROCESS | 22306 | RSS: Main: 186494976 07:23:23 INFO - PROCESS | 22306 | 07:24:13 INFO - PROCESS | 22306 | 1466778253033 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] 07:26:25 INFO - PROCESS | 22306 | Cycle 1(1): loaded http://localhost:34817/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34817/tests/dromaeo/cssquery-ext.html) 07:26:26 INFO - PROCESS | 22306 | RSS: Main: 187822080 07:26:26 INFO - PROCESS | 22306 | 07:29:28 INFO - PROCESS | 22306 | Cycle 1(1): loaded http://localhost:34817/tests/dromaeo/cssquery-ext.html (next: http://localhost:34817/tests/dromaeo/cssquery-jquery.html) 07:29:29 INFO - PROCESS | 22306 | RSS: Main: 187478016 07:29:29 INFO - PROCESS | 22306 | 07:32:31 INFO - PROCESS | 22306 | Cycle 1(1): loaded http://localhost:34817/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34817/tests/dromaeo/cssquery-mootools.html) 07:32:31 INFO - PROCESS | 22306 | RSS: Main: 188071936 07:32:31 INFO - PROCESS | 22306 | 07:35:33 INFO - PROCESS | 22306 | Cycle 1(1): loaded http://localhost:34817/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34817/tests/dromaeo/cssquery-prototype.html) 07:35:34 INFO - PROCESS | 22306 | RSS: Main: 187084800 07:35:34 INFO - PROCESS | 22306 | 07:38:36 INFO - PROCESS | 22306 | Cycle 1(1): loaded http://localhost:34817/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34817/tests/dromaeo/cssquery-yui.html) 07:38:37 INFO - PROCESS | 22306 | RSS: Main: 188416000 07:38:37 INFO - PROCESS | 22306 | 07:41:39 INFO - PROCESS | 22306 | Cycle 1(1): loaded http://localhost:34817/tests/dromaeo/cssquery-yui.html (next: http://localhost:34817/tests/dromaeo/cssquery-dojo.html) 07:41:40 INFO - PROCESS | 22306 | RSS: Main: 190341120 07:41:40 INFO - PROCESS | 22306 | 07:41:40 INFO - PROCESS | 22306 | __start_tp_report 07:41:40 INFO - PROCESS | 22306 | _x_x_mozilla_page_load 07:41:40 INFO - PROCESS | 22306 | _x_x_mozilla_page_load_details 07:41:40 INFO - PROCESS | 22306 | |i|pagename|runs| 07:41:40 INFO - PROCESS | 22306 | |0;dojo.html;2662.0815818542605;2671.2520494261603;2687.771539419149;2692.6768787745473;2696.272006558229;4746.955669752658;4780.187368147414;4809.567138957493;4865.6594038417325;4902.901941961159;4787.760611969396;4854.878628034301;4865.318855360243;4879.048585525824;4890.462049174588;4478.417805685264;4488.438945131858;4604.631629469634;4615.376924115252;4642.698224615389;531.6120090987151;4404.845830395937;4440.533743956887;4446.622037126832;4521.547845215485;4462.085272519126;4477.037436951071;4487.259602165672;4503.234450143451;4516.977415112936;4482.6413886889295;4489.304157855538;4490.236659767847;4516.07420478801;4555.886102847422;4382.0140468394675;4414.977925110386;4420.734755914656;4440.888977775549;4459.777011149462;4696.412948381452;4785.808567657289;4787.234042553175;4789.736564488951;4890.997345544155;5162.845114646567;5164.354455693038;5194.091034069061;5247;5249.42256351801;5201.973990130063;5249.4750524947585;5250.212468129773;5270.367555893279;5282.445343238982;4877.341558889504;4904.852854414374;4918.827841025547;4925.162722337212;4963.726995015309;5212.50481204285;5344.973275133677;5362.383325917492;5403.648762830482;5409.29679141709;5153;5167.0957582422925;5176.068307704574;5186.714730689773;5233.215017747369;5216.087184742655;5234.084035293885;5255.894882102413;5272.525472707474;5318.73406329682;5030.37120359955;5158.097332966716;5170.663906846043;5198.090334191501;5213.270142180022;5106.565941894981;5188.299579556787;5203.973980130075;5206.5314121729225;5255.868603284872;4438.511763705989;4441.045175287264;4469.843555475542;4504.887377815516;4512.120136573402;3790.3177428063213;3815.465834783133;3850.5956874528333;3878.806059697004;3887.7084218683713;4387.692861499664;4466.173757854807;4479.865604031885;4528.343390208402;4541.84103556374;5321.281626980385;5327.227552005015;5337.146056630921;5337.306150200527;5371.704556249444;4418.182636212311;4478.619317358061;4499.752513611783;4504.977475112603;4530.29780384041;4746.311784791186;4746.905061898743;4748.264019077049;4750.643701722315;4796.448408433075;4791.520847915181;4869.878253043773;4875.293082503088;4891.192953162688;4917.680350777188;5029.396472423333;5136.6147538935475;5170.767315470737;5200.167973124282;5217.973910130425;4835.153848076643;4866.221404575251;4869.732164730974;4879.04858552593;4913.852584422473;5147.047796157723;5154.226865970135;5155.149400349051;5159.767810448464;5168.767405466839;5183.585313174862;5265.868353291198;5280.04959107349;5284.286621306228;5334.093204155225;5127.4872512748425;5128.333316668809;5136.12685843415;5138.511841375063;5209.505097015777;4953.603711702983;5041.0422019816115;5091.516305950929;5096.05722941257;5100.056489549445;4935.753212339297;5026.84919452417;5045.697258164522;5046.84859454217;5090.032893750175;5147.845564633067;5148.639595228298;5149.794008239628;5165.870853228699;5183.948160518497;4923.655344125877;5005.6996580205305;5008.449070602158;5041.596672266137;5045.7981680732355 07:41:40 INFO - PROCESS | 22306 | |1;ext.html;538.6668715073071;576.0667718296361;582.2954225387281;596.3201949777252;601.1583782704215;35134.64865351345;39884.40173397398;39959.001024974394;40110.59889401109;40139.39790903139;39004.60995390045;39370.40944385829;39486.80256598713;39601.40597891034;39617.40573891394;7698.576578288192;7818.218178182193;7837.373010159174;7837.804054898616;7844.803879902991;7811.453198276123;7834.960825195894;7878.763637090897;7912.169222231669;7934.087579928324;7813.96093019537;7847.921520784805;7868.724594639189;7900.525968441883;7957.880631790499;7882.330001949841;7883.054033515958;7914.643841027168;7923.12845586985;7934.801629959239;7711.498752581064;7796.259355361231;7826.373890088779;7833.529988200669;7860.6855725771475;38561;38893.41659875104;38900.416493752615;38905.22189556193;38937.221255575016;2567.974320256792;2982.85085745714;3051.52701331294;3052.603161588979;3057.9235519111976;28121.85939070312;28243.85878070617;28446.43107137866;28623;28645.427091458056;3332.9833350833333;3373.291608762163;3378.341223461426;3381.847816848248;3383.881564145268;218992.90503547539;220169;221397;222416;222690;32320.83839580834;32655.67344326574;32656.510152347735;32661;32674.509882351784;33321.83339083289;33335;33993.32013359719;34086.31827363488;35995.460068099;12313.322767247708;12450.06624503166;12504.437300321508;12541.874581254253;12634.368281585885;10931.234813563133;11076.39079850616;11182.440877956069;11213.66359009231;11222.887771122185;18811.43565693004;18833.152508137166;18869.150888210064;18894.81105188958;19014.239430422906;7073.893891591527;7078.1506219254015;7098.325659062484;7145.356917877416;7259;794.7019867549669;896.3635818568889;925.3938670170915;942.5475771629656;1025.4718819807806;27890.163295101178;27936;27997.860010699816;28116.71883281182;28176;952.842780941137;982.3369225772575;995.6614750984555;1017.4099022566893;1028.4446398944485;14592.270386480846;14997.775033374508;15069;15101.244937753068;15244.161571113695;450522;458882;458918;683009;704245;50322.24516632254;51264.23103653448;51387.22919156215;51569;51584.48415515797;1209.5403746576244;1214.7345201199876;1235.7343171218051;1236.3509157692283;1245.059979715309;27882.44235115246;28554.286142846595;29198.416031679673;29356.412871742017;29365.41269174647;43382.34926476042;43831.78084109559;44088.55911440845;44095.33856992212;44188.55811441845;352927;353926;359581;360644;362798;25412;25441.363965901;25870.61194082128;26002.86998565071;26070.608940865524;42326.788366057976;42911.14177716491;42995.57004429916;43062.35406468843;43613;35051.649483504836;35842.64157358393;35955.101122472144;36048.639513604525;36601.81699091488;36062.09844753902;36269.45595816012;36273.093172670895;36596.63403365932;37416.438753419265;35567.46648800218;35639.28721425609;35958.64041359553;36969.63030369662;37195.07012324713;31746.68253317437;33506.83246583751;33874.15314617154;34008.829955850066;34073.65926340705;24460.266192014267;25343.61984570196;25502;25507.46955182695;25555.505834737443 07:41:40 INFO - PROCESS | 22306 | |2;jquery.html;363.83445532282815;372.30750803505475;375.1109869609027;377.65851719340066;388.72206372443713;16161.676766464678;17445.38941137059;17702.380416685417;17842.82157178428;18013.7297940531;11707.356095414749;15614.141222232802;16440;16570.75143872843;17195;4507.166174257764;4666.556677115668;4686.953130468686;4707.1762441572755;4715;3500.404931161696;4627.8148874045;5189.870253243661;5468.781248750065;5476.04169270378;5490.505854473096;5495;5500.669959802404;5504.119340905456;5516.475934786189;5243.082460569385;5458.836234912959;5460.754266058037;5516.806911758089;5518.724063796814;5218.947810521922;5229.686218826882;5232.189010703347;5256.421793602701;5276.81531146408;11664.708382290426;12331.136820422575;12334.50661973529;12343.62969110919;12371.072169587316;1869.0843480384567;1943.922243110288;2003.5291706448972;2101.980539438371;2255.9548809023727;8559.443636163629;8667.089955554638;8804.251638610725;8854.690085847029;9254.768630784285;1661.6593598312438;1665.1258089503108;1683.9073850938194;1700.6598680263874;1735.2538408484347;62935.370646293406;64842.675786621236;66461.33538664647;67801.32198677999;67973.66013169903;9759.609615615296;9776.811969816263;9825.705228843146;9984.800303994025;10128.189744820396;13655.112417692819;13687.657808554866;13722.794158087636;13778.379972901244;13788.655283617989;7365.558066516026;7400.370968467633;7441.962790186014;7571.659275332623;7597.3162415382885;7064.08166938305;7135.8572828544175;7173.0675012248075;7179.748708795271;7282.817929551804;4239.957600424018;4272.060146767706;4290.141971605692;4296.398504209413;4371.082072764755;1531.4410240262446;1639.7376419773018;1643.6137507685685;1791.57002319445;1863.7483939668243;855.5337341149088;907.8547432410915;941.5998200764784;951.4338968313842;960.3277705606104;16284.918575407048;16884.746728799077;16962.982221066777;17201.311947521957;17365.131743412778;863.7192912303526;885.0927799006071;918.8575770755543;922.2437601166979;930.432436213909;9312.255019598417;9425.90574094264;9477.147056764925;9662.613495460102;9797.657082002095;388246;390628;408925;412256;413054;73476.63261683658;75528.62235688786;76506;76893.6155319231;77100.22899771042;923.1414784250711;924.7688077980371;925.6066171876926;934.2759361494896;940.2900809888628;13915.304234788018;14624.70750584961;14905.850941490446;15122.697546048797;15444.30500627452;36386.27227455489;37092.25815483729;37272;38489;39388.60611393849;48508.846924951176;49139;49944.50055499544;50720.23919641135;51125.744371277906;7687.88468172989;7943.4042446817875;7983.20167983197;7984.24149705777;8019.198080191934;8657.091005444337;10815;11475.196736228383;11769.936704118198;12416.689582760504;10064.446455444728;10625.22479319013;10672.30630009047;10876.728081798019;11071.1696622752;5234.633575649668;10675.626353077605;10832.295900766425;10955.178361622751;11120.944395277971;10289.53697083648;10469.895301046892;10512.894871051498;10547.57809687604;10703.411312377893;6681.164854393201;6911.481638877004;6973.5118541701595;7079.8938015930835;7627;7332.890006650011;8835.381523293565;9898.752531186778;9917.752056198653;10223.233257505568 07:41:40 INFO - PROCESS | 22306 | |3;mootools.html;1356.1456282542001;1406.2858682742308;1472.6760112775187;1670.1565709316794;1671.9916400417997;6805.35349141832;7447.292507211813;7448.478606497534;7938.3649308055365;7985.999999999993;7568.432367572426;7747.1090824555195;7817.374610031198;7824.843503129934;7831.960840195791;2224.7997680208778;2241.8766967816764;2252.560750653623;2260.446190683285;2274.1130958926033;2195.714557107574;2198.505336299336;2238.708967834187;2245.3264020793695;2245.4161917901383;2217.412385717778;2231.3529076567775;2243.3270018994317;2246.3148739634403;2249.268987579035;2113.788621137889;2126.170793390579;2132.0832042221837;2132.9040193191345;2136.935891923245;2129.0419311309815;2132.9786702132933;2139.3368055902565;2156.1698745982753;2158.028887000856;7793.610319484003;7918.80202994924;7923.207679232089;7938.325242354407;7965.800854978614;4585.449746030465;4697.483276839579;4698.882527936795;4703.294505824119;4716.882077948078;2980.2549362659333;3049.9390012199856;3169.4453470642547;3181.761367897394;3183.2996740717003;937.5124935033745;978.6738968697455;989.7080361293364;996.970090897267;997.6159178716247;10508.632197873114;10529.157667386591;10532.052115309581;10546.209034322457;10558.155347572176;4089.6932730045364;4249.787510624518;4266.125444283976;4285.871423857289;4299.484061912528;8957.283417326598;9021.50381728998;9029;9030.051844556227;9035.36752427337;4704.29435584665;4769.880752981203;4776.068666609977;4782.234842425195;4798.04039192163;3510.4909788081095;4094.3653733671326;4238.788060596958;4273.572642735701;4369.257226271541;3610.6389361063684;3631.3463576555946;3677.742558020913;3758.981205093957;3765.3222419964122;1200.8018676918384;1211.5638370186725;1229.5450683247077;1231.2735486063266;1235.5243231355992;828.4780588229377;840.0801122770556;845.6194712379331;852.3522123186423;854.0136142755127;5105.770240339194;5174.896502069938;5219.739013049409;5326;5361.946380536145;376.3977635782726;380.7886622924304;383.97504162229365;384.83067450321767;385.5893473450822;3635.9091022724115;3695.57500887396;3700.7224458165747;3774.3206222880144;3777.33896568105;9196.678116265899;9501.382410143318;9587.568559414844;9613.90386096144;9636.71089867305;9438.90561094394;9453.66912158085;9468.857967130498;9471.952640236892;9503.239740820718;7188.820279493055;7324.523905946203;7368.15266244378;7411.036565246483;7423.44324175689;5091.439941606494;5259.973700131475;5333.413324534221;5341.679499230058;5482.698451585042;8497.74506764798;8688.82622347537;8829;8842.557872106498;9018.458892466473;8786.692465763923;9040.050794666728;9042.457452552868;9090.36367454272;9098.181163695299;6133.662648554372;6654.866902662016;6789.1174147360525;6925.27284635106;6960;7664.770056898302;7665.501742386727;7670;7677.270659287359;7733.961330193313;6487.870242595027;6565.179352580927;6604.207495100619;6640.800775976729;6770.763023294161;6378.521610879296;6396.10454536356;6468.353164683682;6504.707288172138;6642.734290628514;6244.968775156095;6287.371262873676;6288.056791481315;6307.369263073656;6319.715612797527;4501.212287849678;4569.771511424482;4593.678442509126;4606.470255920612;4634.884127896829;4412.536683648171;4515.14212299662;4530.977345113253;4540.909181816279;4664.370310008106 07:41:40 INFO - PROCESS | 22306 | |4;prototype.html;295.4032853635656;297.8153544802223;298.59540322862523;300.07576663875255;304.35780503138386;5010.945512339932;5065.924011139836;5093.33786607741;5103.413107492639;5152.562032227256;4986.376702912136;4990.675606085602;5024.145895197816;5059.671121377108;5064.620153488485;3961;3993.880183594497;4006.7395619284725;4011.759294442328;4017.6785857131504;3822.73240873139;3884.32024395731;3935.2129574085156;3998.360262358023;4021.939670904939;3811.2187001664593;3870.4194370844457;3871.2064026874564;3877.941830872539;3878.55396629387;3887.7278590498536;3899.78551179685;3912.8826135215704;3914;3928.2732694451333;3249.6750324967315;3315.9057511021306;3449.189440481485;3454.9309013819834;3455.8617655293756;4850.951490485085;4873.853784386474;4874.829380971649;4889.217725163957;4891.633127515415;4451.15126319156;4500.302453119772;4506.5493450655;4511.458624964992;4522.34426008227;5020.548150666421;5269.841904742864;5279.340082489689;5280.49835265653;5299.152135658276;3628.711807308394;3649.288388764192;3657.1588534636917;3674.026383008505;3713.3687273163355;5430.343745157726;5520.806771762969;5535.612507124543;5549.972250138764;5563.496426608042;3554.2713743682484;3699.7595156314756;3801.125741079567;3801.163743976321;3805.1818858945458;3794.5446546414605;3804.6575808176844;3809.3714537101623;3831.9616803831605;3836.9808150959625;4395.890102747457;4397.944493321644;4398.340248962617;4402.613176849282;4404.810701110746;5155.304033955443;5297.728545149136;5306.177542480922;5317.893642127213;5338.359396872323;1290.3677198173016;1310.7706151423654;1313.1464548043848;1313.39583791457;1314.4873499335267;819.9877001844977;830.7590798668318;844.408290372652;845.3659755183612;845.6448291717494;4132.318167502329;4137.2552940470405;4140.565240649748;4156.58434156588;4168.43726096973;4816.686915350561;4829.372181616438;4848.393950756155;4906.699724572991;4913.140200464904;4089.7750623715983;4097.651699605567;4125.494194618943;4200.768957707294;4210.2842516772225;2511.5102555001963;2527.4945010997876;2585.90949316773;2768.764655004307;2852.3867368515453;5071.518205770446;5077.416097148875;5088.949110508847;5100.38795344561;5108.974455127701;5512.614117011851;5573.359063707644;5578.665280083127;5583.35791383996;5585.413531579125;4850.514948505192;5063.417706963746;5074.289599456005;5082.949170508247;5134.358205224347;5482.972585137049;5486.862828429321;5510.972445137749;5516.779328826802;5520.365158006881;5385.46145385474;5390.97304513475;5407.594430417813;5409.648372855751;5418.593605479684;4792.496787837227;5114.974425127851;5135.486451354835;5136.666116702402;5152.407473140487;3717.4609681596557;3742.176721121349;3750.0249935016545;3756.398976163801;3765.1151979285396;5484.698341591251;5485.561155107662;5495.313085864267;5502.862428439321;5515.862103447446;5007.324011258579;5268.367795864521;5288.81489147878;5304.416514183514;5306.575473962151;5286.39206491243;5322.414534401135;5332.440093790096;5368.43631418711;5371;5159.638825282194;5176.896462070813;5296.2055691646565;5298.059576934838;5302.231176479312;5279.568280617629;5343.732813359395;5351.705656188791;5380.354357477127;5412.350517937715;5242.344706911636;5271.998320319127;5276.841694749163;5293.576513878804;5320.2817619620855 07:41:40 INFO - PROCESS | 22306 | |5;yui.html;708.5005071424646;712.9287071292871;716.5270921192011;723.5694761616837;748.4947660329276;12532.749345013095;13493.730125397498;13525.120867143653;13536.1201521901;13545.322733863291;13311.600651980432;13439.462421503153;13479.595612131627;13522.526711565097;13535.255560944144;616.9691515424222;768.9846203075936;791.9722809701661;793.5199204481293;794.253401802304;775.5463054113351;783.7687882074802;784.0356361675115;784.352908850198;790.0795573157264;831.8752187171912;833.3541505333354;833.5748768128268;834.0700119366893;835.7701632051204;824.4270232188601;828.188375392119;829.4898637338054;830.73001274586;831.966721331146;606.6784604159758;606.7178761875749;607.3895734786555;607.714374244109;607.872346807171;13438.731225375535;13467.393967271497;13490.797638035438;13491.392887319997;13503.25732084735;12081.275123492618;13024.782895487317;13426.91882758174;13553;14021.85978140226;9978.151857092156;10278.359802316318;10330.89669103307;10333.58665653373;10356.326838755456;3306.272620023591;3341.899743007714;3346.7322614190807;3353.312570922955;3428.8114153721535;58424.415755842325;59528.70235648794;59724.70137649327;59738.40261597372;59759.402405975816;10668.519916603771;10676.145908327315;10697.946510267555;10798.892011079788;10801.351918884891;19428.417147485598;19598.510037249183;19616.11727472267;19626.411207663507;20067.29764458237;6965.547239429421;7093.680784364716;7102;7252.166000909858;7391.6673749681395;3763.4354846773203;3833;3842.9615703842605;3849.5188101487315;3863.459115723801;2864.598956146141;2954.5568164775027;2983.1498023063323;2994.7454466370605;2998.895038673636;489.2172523961633;489.6963882392868;494.9406071271471;501.15555289337584;505.6081536809003;541.934967803866;550.2022068001414;565.2566874559941;572.1446437575768;597.8834127345126;7877.842443151219;7938.166492518318;8149.877751833727;8226.547539885363;8284.958575207085;493.0090518058656;534.7059117485445;561.6742289472096;565.4958257479198;565.9490645841812;3950.4469374287623;4069.91860162801;4074.083331250445;4128.1330920506425;4147.564505726855;78556.82164767533;90454.54772726225;93517.5324123375;94361.5281923586;95890.5205473982;81712.18287817165;81878.59060704659;82062.58968705118;82636.17363826405;82690.17309826825;43441.34837977433;45106.548934510894;72117.63941180261;74799;75731.0525160186;7730.922690773245;7813.648385822538;7825.608719564113;7844.686212551663;8020;43842;44093.33859992167;45079.54920450754;45482.77258613686;45503.54496454993;61701;62757;63371.366286336546;63693;64030;10472.633457828939;10552.947235263775;10575;10664.893351066701;11087.33475991443;10665.89334106649;10723.19576031785;10755.462226888469;10819.945900270763;11036.724081898017;9511.857322140035;9694.175995040501;9756.756081098029;9841.95079024629;9873.40759554429;9774.218062554837;9927.652532161339;9948.602055917972;10163.593456261668;10274.640387586398;9679.758006049906;9703.514824258618;9751.3661611995;9865.309428340235;9947.801043978936;8496.660133594587;8576.828463430822;8817.338699597427;8826.5586720665;8882.200601945857;8774.473531588124;9244.168024877794;9286.257099431894;9373.343865929592;9382.202512786216 07:41:40 INFO - PROCESS | 22306 | __end_tp_report 07:41:40 INFO - PROCESS | 22306 | __start_cc_report 07:41:40 INFO - PROCESS | 22306 | _x_x_mozilla_cycle_collect,393 07:41:40 INFO - PROCESS | 22306 | __end_cc_report 07:41:40 INFO - PROCESS | 22306 | __startTimestamp1466779300090__endTimestamp 07:41:40 INFO - PROCESS | 22306 | 07:41:40 INFO - PROCESS | 22306 | ------- Summary: start ------- 07:41:40 INFO - PROCESS | 22306 | Number of tests: 6 07:41:40 INFO - PROCESS | 22306 | 07:41:40 INFO - PROCESS | 22306 | [#0] dojo.html Cycles:165 Average:4800.31 Median:4923.66 stddev:614.52 (12.5%) stddev-sans-first:593.07 07:41:40 INFO - PROCESS | 22306 | Values: 2662.1 2671.3 2687.8 2692.7 2696.3 4747.0 4780.2 4809.6 4865.7 4902.9 4787.8 4854.9 4865.3 4879.0 4890.5 4478.4 4488.4 4604.6 4615.4 4642.7 531.6 4404.8 4440.5 4446.6 4521.5 4462.1 4477.0 4487.3 4503.2 4517.0 4482.6 4489.3 4490.2 4516.1 4555.9 4382.0 4415.0 4420.7 4440.9 4459.8 4696.4 4785.8 4787.2 4789.7 4891.0 5162.8 5164.4 5194.1 5247.0 5249.4 5202.0 5249.5 5250.2 5270.4 5282.4 4877.3 4904.9 4918.8 4925.2 4963.7 5212.5 5345.0 5362.4 5403.6 5409.3 5153.0 5167.1 5176.1 5186.7 5233.2 5216.1 5234.1 5255.9 5272.5 5318.7 5030.4 5158.1 5170.7 5198.1 5213.3 5106.6 5188.3 5204.0 5206.5 5255.9 4438.5 4441.0 4469.8 4504.9 4512.1 3790.3 3815.5 3850.6 3878.8 3887.7 4387.7 4466.2 4479.9 4528.3 4541.8 5321.3 5327.2 5337.1 5337.3 5371.7 4418.2 4478.6 4499.8 4505.0 4530.3 4746.3 4746.9 4748.3 4750.6 4796.4 4791.5 4869.9 4875.3 4891.2 4917.7 5029.4 5136.6 5170.8 5200.2 5218.0 4835.2 4866.2 4869.7 4879.0 4913.9 5147.0 5154.2 5155.1 5159.8 5168.8 5183.6 5265.9 5280.0 5284.3 5334.1 5127.5 5128.3 5136.1 5138.5 5209.5 4953.6 5041.0 5091.5 5096.1 5100.1 4935.8 5026.8 5045.7 5046.8 5090.0 5147.8 5148.6 5149.8 5165.9 5183.9 4923.7 5005.7 5008.4 5041.6 5045.8 07:41:40 INFO - PROCESS | 22306 | 07:41:40 INFO - PROCESS | 22306 | [#1] ext.html Cycles:180 Average:51244.45 Median:197769.82 stddev:108712.86 (55.0%) stddev-sans-first:108951.17 07:41:40 INFO - PROCESS | 22306 | Values: 538.7 576.1 582.3 596.3 601.2 35134.6 39884.4 39959.0 40110.6 40139.4 39004.6 39370.4 39486.8 39601.4 39617.4 7698.6 7818.2 7837.4 7837.8 7844.8 7811.5 7835.0 7878.8 7912.2 7934.1 7814.0 7847.9 7868.7 7900.5 7957.9 7882.3 7883.1 7914.6 7923.1 7934.8 7711.5 7796.3 7826.4 7833.5 7860.7 38561.0 38893.4 38900.4 38905.2 38937.2 2568.0 2982.9 3051.5 3052.6 3057.9 28121.9 28243.9 28446.4 28623.0 28645.4 3333.0 3373.3 3378.3 3381.8 3383.9 218992.9 220169.0 221397.0 222416.0 222690.0 32320.8 32655.7 32656.5 32661.0 32674.5 33321.8 33335.0 33993.3 34086.3 35995.5 12313.3 12450.1 12504.4 12541.9 12634.4 10931.2 11076.4 11182.4 11213.7 11222.9 18811.4 18833.2 18869.2 18894.8 19014.2 7073.9 7078.2 7098.3 7145.4 7259.0 794.7 896.4 925.4 942.5 1025.5 27890.2 27936.0 27997.9 28116.7 28176.0 952.8 982.3 995.7 1017.4 1028.4 14592.3 14997.8 15069.0 15101.2 15244.2 450522.0 458882.0 458918.0 683009.0 704245.0 50322.2 51264.2 51387.2 51569.0 51584.5 1209.5 1214.7 1235.7 1236.4 1245.1 27882.4 28554.3 29198.4 29356.4 29365.4 43382.3 43831.8 44088.6 44095.3 44188.6 352927.0 353926.0 359581.0 360644.0 362798.0 25412.0 25441.4 25870.6 26002.9 26070.6 42326.8 42911.1 42995.6 43062.4 43613.0 35051.6 35842.6 35955.1 36048.6 36601.8 36062.1 36269.5 36273.1 36596.6 37416.4 35567.5 35639.3 35958.6 36969.6 37195.1 31746.7 33506.8 33874.2 34008.8 34073.7 24460.3 25343.6 25502.0 25507.5 25555.5 07:41:40 INFO - PROCESS | 22306 | 07:41:40 INFO - PROCESS | 22306 | [#2] jquery.html Cycles:180 Average:24176.97 Median:4711.09 stddev:66390.30 (1409.2%) stddev-sans-first:66552.46 07:41:40 INFO - PROCESS | 22306 | Values: 363.8 372.3 375.1 377.7 388.7 16161.7 17445.4 17702.4 17842.8 18013.7 11707.4 15614.1 16440.0 16570.8 17195.0 4507.2 4666.6 4687.0 4707.2 4715.0 3500.4 4627.8 5189.9 5468.8 5476.0 5490.5 5495.0 5500.7 5504.1 5516.5 5243.1 5458.8 5460.8 5516.8 5518.7 5218.9 5229.7 5232.2 5256.4 5276.8 11664.7 12331.1 12334.5 12343.6 12371.1 1869.1 1943.9 2003.5 2102.0 2256.0 8559.4 8667.1 8804.3 8854.7 9254.8 1661.7 1665.1 1683.9 1700.7 1735.3 62935.4 64842.7 66461.3 67801.3 67973.7 9759.6 9776.8 9825.7 9984.8 10128.2 13655.1 13687.7 13722.8 13778.4 13788.7 7365.6 7400.4 7442.0 7571.7 7597.3 7064.1 7135.9 7173.1 7179.7 7282.8 4240.0 4272.1 4290.1 4296.4 4371.1 1531.4 1639.7 1643.6 1791.6 1863.7 855.5 907.9 941.6 951.4 960.3 16284.9 16884.7 16963.0 17201.3 17365.1 863.7 885.1 918.9 922.2 930.4 9312.3 9425.9 9477.1 9662.6 9797.7 388246.0 390628.0 408925.0 412256.0 413054.0 73476.6 75528.6 76506.0 76893.6 77100.2 923.1 924.8 925.6 934.3 940.3 13915.3 14624.7 14905.9 15122.7 15444.3 36386.3 37092.3 37272.0 38489.0 39388.6 48508.8 49139.0 49944.5 50720.2 51125.7 7687.9 7943.4 7983.2 7984.2 8019.2 8657.1 10815.0 11475.2 11769.9 12416.7 10064.4 10625.2 10672.3 10876.7 11071.2 5234.6 10675.6 10832.3 10955.2 11120.9 10289.5 10469.9 10512.9 10547.6 10703.4 6681.2 6911.5 6973.5 7079.9 7627.0 7332.9 8835.4 9898.8 9917.8 10223.2 07:41:40 INFO - PROCESS | 22306 | 07:41:40 INFO - PROCESS | 22306 | [#3] mootools.html Cycles:180 Average:5124.54 Median:5098.61 stddev:2852.50 (55.9%) stddev-sans-first:2846.45 07:41:40 INFO - PROCESS | 22306 | Values: 1356.1 1406.3 1472.7 1670.2 1672.0 6805.4 7447.3 7448.5 7938.4 7986.0 7568.4 7747.1 7817.4 7824.8 7832.0 2224.8 2241.9 2252.6 2260.4 2274.1 2195.7 2198.5 2238.7 2245.3 2245.4 2217.4 2231.4 2243.3 2246.3 2249.3 2113.8 2126.2 2132.1 2132.9 2136.9 2129.0 2133.0 2139.3 2156.2 2158.0 7793.6 7918.8 7923.2 7938.3 7965.8 4585.4 4697.5 4698.9 4703.3 4716.9 2980.3 3049.9 3169.4 3181.8 3183.3 937.5 978.7 989.7 997.0 997.6 10508.6 10529.2 10532.1 10546.2 10558.2 4089.7 4249.8 4266.1 4285.9 4299.5 8957.3 9021.5 9029.0 9030.1 9035.4 4704.3 4769.9 4776.1 4782.2 4798.0 3510.5 4094.4 4238.8 4273.6 4369.3 3610.6 3631.3 3677.7 3759.0 3765.3 1200.8 1211.6 1229.5 1231.3 1235.5 828.5 840.1 845.6 852.4 854.0 5105.8 5174.9 5219.7 5326.0 5361.9 376.4 380.8 384.0 384.8 385.6 3635.9 3695.6 3700.7 3774.3 3777.3 9196.7 9501.4 9587.6 9613.9 9636.7 9438.9 9453.7 9468.9 9472.0 9503.2 7188.8 7324.5 7368.2 7411.0 7423.4 5091.4 5260.0 5333.4 5341.7 5482.7 8497.7 8688.8 8829.0 8842.6 9018.5 8786.7 9040.1 9042.5 9090.4 9098.2 6133.7 6654.9 6789.1 6925.3 6960.0 7664.8 7665.5 7670.0 7677.3 7734.0 6487.9 6565.2 6604.2 6640.8 6770.8 6378.5 6396.1 6468.4 6504.7 6642.7 6245.0 6287.4 6288.1 6307.4 6319.7 4501.2 4569.8 4593.7 4606.5 4634.9 4412.5 4515.1 4531.0 4540.9 4664.4 07:41:40 INFO - PROCESS | 22306 | 07:41:40 INFO - PROCESS | 22306 | [#4] prototype.html Cycles:180 Average:4328.62 Median:4909.92 stddev:1294.84 (26.4%) stddev-sans-first:1262.59 07:41:40 INFO - PROCESS | 22306 | Values: 295.4 297.8 298.6 300.1 304.4 5010.9 5065.9 5093.3 5103.4 5152.6 4986.4 4990.7 5024.1 5059.7 5064.6 3961.0 3993.9 4006.7 4011.8 4017.7 3822.7 3884.3 3935.2 3998.4 4021.9 3811.2 3870.4 3871.2 3877.9 3878.6 3887.7 3899.8 3912.9 3914.0 3928.3 3249.7 3315.9 3449.2 3454.9 3455.9 4851.0 4873.9 4874.8 4889.2 4891.6 4451.2 4500.3 4506.5 4511.5 4522.3 5020.5 5269.8 5279.3 5280.5 5299.2 3628.7 3649.3 3657.2 3674.0 3713.4 5430.3 5520.8 5535.6 5550.0 5563.5 3554.3 3699.8 3801.1 3801.2 3805.2 3794.5 3804.7 3809.4 3832.0 3837.0 4395.9 4397.9 4398.3 4402.6 4404.8 5155.3 5297.7 5306.2 5317.9 5338.4 1290.4 1310.8 1313.1 1313.4 1314.5 820.0 830.8 844.4 845.4 845.6 4132.3 4137.3 4140.6 4156.6 4168.4 4816.7 4829.4 4848.4 4906.7 4913.1 4089.8 4097.7 4125.5 4200.8 4210.3 2511.5 2527.5 2585.9 2768.8 2852.4 5071.5 5077.4 5088.9 5100.4 5109.0 5512.6 5573.4 5578.7 5583.4 5585.4 4850.5 5063.4 5074.3 5082.9 5134.4 5483.0 5486.9 5511.0 5516.8 5520.4 5385.5 5391.0 5407.6 5409.6 5418.6 4792.5 5115.0 5135.5 5136.7 5152.4 3717.5 3742.2 3750.0 3756.4 3765.1 5484.7 5485.6 5495.3 5502.9 5515.9 5007.3 5268.4 5288.8 5304.4 5306.6 5286.4 5322.4 5332.4 5368.4 5371.0 5159.6 5176.9 5296.2 5298.1 5302.2 5279.6 5343.7 5351.7 5380.4 5412.4 5242.3 5272.0 5276.8 5293.6 5320.3 07:41:40 INFO - PROCESS | 22306 | 07:41:40 INFO - PROCESS | 22306 | [#5] yui.html Cycles:180 Average:16913.21 Median:59731.55 stddev:23959.89 (40.1%) stddev-sans-first:23996.21 07:41:40 INFO - PROCESS | 22306 | Values: 708.5 712.9 716.5 723.6 748.5 12532.7 13493.7 13525.1 13536.1 13545.3 13311.6 13439.5 13479.6 13522.5 13535.3 617.0 769.0 792.0 793.5 794.3 775.5 783.8 784.0 784.4 790.1 831.9 833.4 833.6 834.1 835.8 824.4 828.2 829.5 830.7 832.0 606.7 606.7 607.4 607.7 607.9 13438.7 13467.4 13490.8 13491.4 13503.3 12081.3 13024.8 13426.9 13553.0 14021.9 9978.2 10278.4 10330.9 10333.6 10356.3 3306.3 3341.9 3346.7 3353.3 3428.8 58424.4 59528.7 59724.7 59738.4 59759.4 10668.5 10676.1 10697.9 10798.9 10801.4 19428.4 19598.5 19616.1 19626.4 20067.3 6965.5 7093.7 7102.0 7252.2 7391.7 3763.4 3833.0 3843.0 3849.5 3863.5 2864.6 2954.6 2983.1 2994.7 2998.9 489.2 489.7 494.9 501.2 505.6 541.9 550.2 565.3 572.1 597.9 7877.8 7938.2 8149.9 8226.5 8285.0 493.0 534.7 561.7 565.5 565.9 3950.4 4069.9 4074.1 4128.1 4147.6 78556.8 90454.5 93517.5 94361.5 95890.5 81712.2 81878.6 82062.6 82636.2 82690.2 43441.3 45106.5 72117.6 74799.0 75731.1 7730.9 7813.6 7825.6 7844.7 8020.0 43842.0 44093.3 45079.5 45482.8 45503.5 61701.0 62757.0 63371.4 63693.0 64030.0 10472.6 10552.9 10575.0 10664.9 11087.3 10665.9 10723.2 10755.5 10819.9 11036.7 9511.9 9694.2 9756.8 9842.0 9873.4 9774.2 9927.7 9948.6 10163.6 10274.6 9679.8 9703.5 9751.4 9865.3 9947.8 8496.7 8576.8 8817.3 8826.6 8882.2 8774.5 9244.2 9286.3 9373.3 9382.2 07:41:40 INFO - PROCESS | 22306 | -------- Summary: end -------- 07:41:40 INFO - PROCESS | 22306 | 07:41:40 INFO - TEST-INFO | 22306: exit 0 07:41:40 INFO - TEST-OK | dromaeo_css | took 1116129ms 07:41:40 INFO - TEST-START | kraken 07:41:40 INFO - operating with platform_type : linux_ 07:41:40 INFO - Initialising browser for kraken test... 07:41:40 INFO - TEST-INFO | started process 22566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpql9Pbb/profile http://localhost:34817/getInfo.html) 07:41:45 INFO - PROCESS | 22566 | __metrics Screen width/height:1600/1200 07:41:45 INFO - PROCESS | 22566 | colorDepth:24 07:41:45 INFO - PROCESS | 22566 | Browser inner width/height: 1024/697 07:41:45 INFO - PROCESS | 22566 | __metrics 07:41:46 ERROR - PROCESS | 22566 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:41:47 INFO - TEST-INFO | 22566: exit 0 07:41:47 INFO - Browser initialized. 07:41:47 INFO - Running cycle 1/1 for kraken test... 07:41:47 INFO - TEST-INFO | started process 22686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpql9Pbb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:41:59 INFO - PROCESS | 22686 | RSS: Main: 186028032 07:41:59 INFO - PROCESS | 22686 | 07:42:02 INFO - PROCESS | 22686 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34817/tests/kraken/driver.html?testName=audio-beat-detection) 07:42:03 INFO - PROCESS | 22686 | RSS: Main: 191438848 07:42:03 INFO - PROCESS | 22686 | 07:42:06 INFO - PROCESS | 22686 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34817/tests/kraken/driver.html?testName=audio-dft) 07:42:06 INFO - PROCESS | 22686 | RSS: Main: 190795776 07:42:06 INFO - PROCESS | 22686 | 07:42:09 INFO - PROCESS | 22686 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34817/tests/kraken/driver.html?testName=audio-fft) 07:42:10 INFO - PROCESS | 22686 | RSS: Main: 186236928 07:42:10 INFO - PROCESS | 22686 | 07:42:12 INFO - PROCESS | 22686 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34817/tests/kraken/driver.html?testName=audio-oscillator) 07:42:12 INFO - PROCESS | 22686 | RSS: Main: 186683392 07:42:12 INFO - PROCESS | 22686 | 07:42:15 INFO - PROCESS | 22686 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34817/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:42:15 INFO - PROCESS | 22686 | RSS: Main: 187158528 07:42:15 INFO - PROCESS | 22686 | 07:42:19 INFO - PROCESS | 22686 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34817/tests/kraken/driver.html?testName=imaging-darkroom) 07:42:19 INFO - PROCESS | 22686 | RSS: Main: 187584512 07:42:19 INFO - PROCESS | 22686 | 07:42:23 INFO - PROCESS | 22686 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34817/tests/kraken/driver.html?testName=imaging-desaturate) 07:42:23 INFO - PROCESS | 22686 | RSS: Main: 184733696 07:42:23 INFO - PROCESS | 22686 | 07:42:26 INFO - PROCESS | 22686 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34817/tests/kraken/driver.html?testName=json-parse-financial) 07:42:27 INFO - PROCESS | 22686 | RSS: Main: 185765888 07:42:27 INFO - PROCESS | 22686 | 07:42:29 INFO - PROCESS | 22686 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34817/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:42:29 INFO - PROCESS | 22686 | RSS: Main: 186470400 07:42:29 INFO - PROCESS | 22686 | 07:42:31 INFO - PROCESS | 22686 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34817/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:42:32 INFO - PROCESS | 22686 | RSS: Main: 186626048 07:42:32 INFO - PROCESS | 22686 | 07:42:34 INFO - PROCESS | 22686 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34817/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:42:35 INFO - PROCESS | 22686 | RSS: Main: 186925056 07:42:35 INFO - PROCESS | 22686 | 07:42:37 INFO - PROCESS | 22686 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34817/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:42:38 INFO - PROCESS | 22686 | RSS: Main: 186867712 07:42:38 INFO - PROCESS | 22686 | 07:42:41 INFO - PROCESS | 22686 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34817/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:42:42 INFO - PROCESS | 22686 | RSS: Main: 187023360 07:42:42 INFO - PROCESS | 22686 | 07:42:43 INFO - PROCESS | 22686 | Cycle 1(1): loaded http://localhost:34817/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34817/tests/kraken/driver.html?testName=ai-astar) 07:42:44 INFO - PROCESS | 22686 | RSS: Main: 187666432 07:42:44 INFO - PROCESS | 22686 | 07:42:44 INFO - PROCESS | 22686 | __start_tp_report 07:42:44 INFO - PROCESS | 22686 | _x_x_mozilla_page_load 07:42:44 INFO - PROCESS | 22686 | _x_x_mozilla_page_load_details 07:42:44 INFO - PROCESS | 22686 | |i|pagename|runs| 07:42:44 INFO - PROCESS | 22686 | |0;ai-astar;106;116;109;115;114;114;116;114;116;115 07:42:44 INFO - PROCESS | 22686 | |1;audio-beat-detection;165;131;170;178;134;167;161;139;183;135 07:42:44 INFO - PROCESS | 22686 | |2;audio-dft;165;165;179;164;162;163;179;164;163;165 07:42:44 INFO - PROCESS | 22686 | |3;audio-fft;77;77;77;158;77;77;76;78;159;76 07:42:44 INFO - PROCESS | 22686 | |4;audio-oscillator;89;87;138;87;89;87;139;88;86;134 07:42:44 INFO - PROCESS | 22686 | |5;imaging-gaussian-blur;118;118;118;117;117;119;120;118;119;119 07:42:44 INFO - PROCESS | 22686 | |6;imaging-darkroom;148;148;147;147;147;148;149;147;147;147 07:42:44 INFO - PROCESS | 22686 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;96 07:42:44 INFO - PROCESS | 22686 | |8;json-parse-financial;64;67;65;66;65;66;66;66;66;65 07:42:44 INFO - PROCESS | 22686 | |9;json-stringify-tinderbox;67;65;66;66;66;66;65;65;65;65 07:42:44 INFO - PROCESS | 22686 | |10;stanford-crypto-aes;83;84;82;83;85;83;84;84;100;85 07:42:44 INFO - PROCESS | 22686 | |11;stanford-crypto-ccm;133;133;134;137;140;131;136;137;144;136 07:42:44 INFO - PROCESS | 22686 | |12;stanford-crypto-pbkdf2;174;176;177;178;173;180;176;176;176;177 07:42:44 INFO - PROCESS | 22686 | |13;stanford-crypto-sha256-iterative;68;68;68;73;67;71;69;69;73;67 07:42:44 INFO - PROCESS | 22686 | __end_tp_report 07:42:44 INFO - PROCESS | 22686 | __start_cc_report 07:42:44 INFO - PROCESS | 22686 | _x_x_mozilla_cycle_collect,960 07:42:44 INFO - PROCESS | 22686 | __end_cc_report 07:42:44 INFO - PROCESS | 22686 | __startTimestamp1466779364208__endTimestamp 07:42:44 INFO - PROCESS | 22686 | 07:42:44 INFO - PROCESS | 22686 | ------- Summary: start ------- 07:42:44 INFO - PROCESS | 22686 | Number of tests: 14 07:42:44 INFO - PROCESS | 22686 | 07:42:44 INFO - PROCESS | 22686 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:3.34 (2.9%) stddev-sans-first:2.18 07:42:44 INFO - PROCESS | 22686 | Values: 106.0 116.0 109.0 115.0 114.0 114.0 116.0 114.0 116.0 115.0 07:42:44 INFO - PROCESS | 22686 | 07:42:44 INFO - PROCESS | 22686 | [#1] audio-beat-detection Cycles:10 Average:156.30 Median:166.00 stddev:19.65 (11.8%) stddev-sans-first:20.59 07:42:44 INFO - PROCESS | 22686 | Values: 165.0 131.0 170.0 178.0 134.0 167.0 161.0 139.0 183.0 135.0 07:42:44 INFO - PROCESS | 22686 | 07:42:44 INFO - PROCESS | 22686 | [#2] audio-dft Cycles:10 Average:166.90 Median:165.00 stddev:6.45 (3.9%) stddev-sans-first:6.81 07:42:44 INFO - PROCESS | 22686 | Values: 165.0 165.0 179.0 164.0 162.0 163.0 179.0 164.0 163.0 165.0 07:42:44 INFO - PROCESS | 22686 | 07:42:44 INFO - PROCESS | 22686 | [#3] audio-fft Cycles:10 Average:93.20 Median:77.00 stddev:34.42 (44.7%) stddev-sans-first:36.01 07:42:44 INFO - PROCESS | 22686 | Values: 77.0 77.0 77.0 158.0 77.0 77.0 76.0 78.0 159.0 76.0 07:42:44 INFO - PROCESS | 22686 | 07:42:44 INFO - PROCESS | 22686 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:87.00 stddev:23.93 (27.5%) stddev-sans-first:24.88 07:42:44 INFO - PROCESS | 22686 | Values: 89.0 87.0 138.0 87.0 89.0 87.0 139.0 88.0 86.0 134.0 07:42:44 INFO - PROCESS | 22686 | 07:42:44 INFO - PROCESS | 22686 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.50 stddev:0.95 (0.8%) stddev-sans-first:1.00 07:42:44 INFO - PROCESS | 22686 | Values: 118.0 118.0 118.0 117.0 117.0 119.0 120.0 118.0 119.0 119.0 07:42:44 INFO - PROCESS | 22686 | 07:42:44 INFO - PROCESS | 22686 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 07:42:44 INFO - PROCESS | 22686 | Values: 148.0 148.0 147.0 147.0 147.0 148.0 149.0 147.0 147.0 147.0 07:42:44 INFO - PROCESS | 22686 | 07:42:44 INFO - PROCESS | 22686 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:42:44 INFO - PROCESS | 22686 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 07:42:44 INFO - PROCESS | 22686 | 07:42:44 INFO - PROCESS | 22686 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:66.00 stddev:0.84 (1.3%) stddev-sans-first:0.67 07:42:44 INFO - PROCESS | 22686 | Values: 64.0 67.0 65.0 66.0 65.0 66.0 66.0 66.0 66.0 65.0 07:42:44 INFO - PROCESS | 22686 | 07:42:44 INFO - PROCESS | 22686 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 07:42:44 INFO - PROCESS | 22686 | Values: 67.0 65.0 66.0 66.0 66.0 66.0 65.0 65.0 65.0 65.0 07:42:44 INFO - PROCESS | 22686 | 07:42:44 INFO - PROCESS | 22686 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.00 stddev:5.25 (6.3%) stddev-sans-first:5.50 07:42:44 INFO - PROCESS | 22686 | Values: 83.0 84.0 82.0 83.0 85.0 83.0 84.0 84.0 100.0 85.0 07:42:44 INFO - PROCESS | 22686 | 07:42:44 INFO - PROCESS | 22686 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:136.50 stddev:3.78 (2.8%) stddev-sans-first:3.84 07:42:44 INFO - PROCESS | 22686 | Values: 133.0 133.0 134.0 137.0 140.0 131.0 136.0 137.0 144.0 136.0 07:42:44 INFO - PROCESS | 22686 | 07:42:44 INFO - PROCESS | 22686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:176.50 stddev:1.95 (1.1%) stddev-sans-first:1.88 07:42:44 INFO - PROCESS | 22686 | Values: 174.0 176.0 177.0 178.0 173.0 180.0 176.0 176.0 176.0 177.0 07:42:44 INFO - PROCESS | 22686 | 07:42:44 INFO - PROCESS | 22686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:2.26 (3.3%) stddev-sans-first:2.35 07:42:44 INFO - PROCESS | 22686 | Values: 68.0 68.0 68.0 73.0 67.0 71.0 69.0 69.0 73.0 67.0 07:42:44 INFO - PROCESS | 22686 | -------- Summary: end -------- 07:42:44 INFO - PROCESS | 22686 | 07:42:45 INFO - TEST-INFO | 22686: exit 0 07:42:45 INFO - TEST-OK | kraken | took 64425ms 07:42:45 INFO - SUITE-END | took 1180s 07:42:45 INFO - Completed test suite (00:19:40) 07:42:45 INFO - javascript benchmark 07:42:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6370.714461420886, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2662.0815818542605, 2671.2520494261603, 2687.771539419149, 2692.6768787745473, 2696.272006558229, 4746.955669752658, 4780.187368147414, 4809.567138957493, 4865.6594038417325, 4902.901941961159, 4787.760611969396, 4854.878628034301, 4865.318855360243, 4879.048585525824, 4890.462049174588, 4478.417805685264, 4488.438945131858, 4604.631629469634, 4615.376924115252, 4642.698224615389, 531.6120090987151, 4404.845830395937, 4440.533743956887, 4446.622037126832, 4521.547845215485, 4462.085272519126, 4477.037436951071, 4487.259602165672, 4503.234450143451, 4516.977415112936, 4482.6413886889295, 4489.304157855538, 4490.236659767847, 4516.07420478801, 4555.886102847422, 4382.0140468394675, 4414.977925110386, 4420.734755914656, 4440.888977775549, 4459.777011149462, 4696.412948381452, 4785.808567657289, 4787.234042553175, 4789.736564488951, 4890.997345544155, 5162.845114646567, 5164.354455693038, 5194.091034069061, 5247.0, 5249.42256351801, 5201.973990130063, 5249.4750524947585, 5250.212468129773, 5270.367555893279, 5282.445343238982, 4877.341558889504, 4904.852854414374, 4918.827841025547, 4925.162722337212, 4963.726995015309, 5212.50481204285, 5344.973275133677, 5362.383325917492, 5403.648762830482, 5409.29679141709, 5153.0, 5167.0957582422925, 5176.068307704574, 5186.714730689773, 5233.215017747369, 5216.087184742655, 5234.084035293885, 5255.894882102413, 5272.525472707474, 5318.73406329682, 5030.37120359955, 5158.097332966716, 5170.663906846043, 5198.090334191501, 5213.270142180022, 5106.565941894981, 5188.299579556787, 5203.973980130075, 5206.5314121729225, 5255.868603284872, 4438.511763705989, 4441.045175287264, 4469.843555475542, 4504.887377815516, 4512.120136573402, 3790.3177428063213, 3815.465834783133, 3850.5956874528333, 3878.806059697004, 3887.7084218683713, 4387.692861499664, 4466.173757854807, 4479.865604031885, 4528.343390208402, 4541.84103556374, 5321.281626980385, 5327.227552005015, 5337.146056630921, 5337.306150200527, 5371.704556249444, 4418.182636212311, 4478.619317358061, 4499.752513611783, 4504.977475112603, 4530.29780384041, 4746.311784791186, 4746.905061898743, 4748.264019077049, 4750.643701722315, 4796.448408433075, 4791.520847915181, 4869.878253043773, 4875.293082503088, 4891.192953162688, 4917.680350777188, 5029.396472423333, 5136.6147538935475, 5170.767315470737, 5200.167973124282, 5217.973910130425, 4835.153848076643, 4866.221404575251, 4869.732164730974, 4879.04858552593, 4913.852584422473, 5147.047796157723, 5154.226865970135, 5155.149400349051, 5159.767810448464, 5168.767405466839, 5183.585313174862, 5265.868353291198, 5280.04959107349, 5284.286621306228, 5334.093204155225, 5127.4872512748425, 5128.333316668809, 5136.12685843415, 5138.511841375063, 5209.505097015777, 4953.603711702983, 5041.0422019816115, 5091.516305950929, 5096.05722941257, 5100.056489549445, 4935.753212339297, 5026.84919452417, 5045.697258164522, 5046.84859454217, 5090.032893750175, 5147.845564633067, 5148.639595228298, 5149.794008239628, 5165.870853228699, 5183.948160518497, 4923.655344125877, 5005.6996580205305, 5008.449070602158, 5041.596672266137, 5045.7981680732355], "value": 4762.113253634294, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.6668715073071, 576.0667718296361, 582.2954225387281, 596.3201949777252, 601.1583782704215, 35134.64865351345, 39884.40173397398, 39959.001024974394, 40110.59889401109, 40139.39790903139, 39004.60995390045, 39370.40944385829, 39486.80256598713, 39601.40597891034, 39617.40573891394, 7698.576578288192, 7818.218178182193, 7837.373010159174, 7837.804054898616, 7844.803879902991, 7811.453198276123, 7834.960825195894, 7878.763637090897, 7912.169222231669, 7934.087579928324, 7813.96093019537, 7847.921520784805, 7868.724594639189, 7900.525968441883, 7957.880631790499, 7882.330001949841, 7883.054033515958, 7914.643841027168, 7923.12845586985, 7934.801629959239, 7711.498752581064, 7796.259355361231, 7826.373890088779, 7833.529988200669, 7860.6855725771475, 38561.0, 38893.41659875104, 38900.416493752615, 38905.22189556193, 38937.221255575016, 2567.974320256792, 2982.85085745714, 3051.52701331294, 3052.603161588979, 3057.9235519111976, 28121.85939070312, 28243.85878070617, 28446.43107137866, 28623.0, 28645.427091458056, 3332.9833350833333, 3373.291608762163, 3378.341223461426, 3381.847816848248, 3383.881564145268, 218992.90503547539, 220169.0, 221397.0, 222416.0, 222690.0, 32320.83839580834, 32655.67344326574, 32656.510152347735, 32661.0, 32674.509882351784, 33321.83339083289, 33335.0, 33993.32013359719, 34086.31827363488, 35995.460068099, 12313.322767247708, 12450.06624503166, 12504.437300321508, 12541.874581254253, 12634.368281585885, 10931.234813563133, 11076.39079850616, 11182.440877956069, 11213.66359009231, 11222.887771122185, 18811.43565693004, 18833.152508137166, 18869.150888210064, 18894.81105188958, 19014.239430422906, 7073.893891591527, 7078.1506219254015, 7098.325659062484, 7145.356917877416, 7259.0, 794.7019867549669, 896.3635818568889, 925.3938670170915, 942.5475771629656, 1025.4718819807806, 27890.163295101178, 27936.0, 27997.860010699816, 28116.71883281182, 28176.0, 952.842780941137, 982.3369225772575, 995.6614750984555, 1017.4099022566893, 1028.4446398944485, 14592.270386480846, 14997.775033374508, 15069.0, 15101.244937753068, 15244.161571113695, 450522.0, 458882.0, 458918.0, 683009.0, 704245.0, 50322.24516632254, 51264.23103653448, 51387.22919156215, 51569.0, 51584.48415515797, 1209.5403746576244, 1214.7345201199876, 1235.7343171218051, 1236.3509157692283, 1245.059979715309, 27882.44235115246, 28554.286142846595, 29198.416031679673, 29356.412871742017, 29365.41269174647, 43382.34926476042, 43831.78084109559, 44088.55911440845, 44095.33856992212, 44188.55811441845, 352927.0, 353926.0, 359581.0, 360644.0, 362798.0, 25412.0, 25441.363965901, 25870.61194082128, 26002.86998565071, 26070.608940865524, 42326.788366057976, 42911.14177716491, 42995.57004429916, 43062.35406468843, 43613.0, 35051.649483504836, 35842.64157358393, 35955.101122472144, 36048.639513604525, 36601.81699091488, 36062.09844753902, 36269.45595816012, 36273.093172670895, 36596.63403365932, 37416.438753419265, 35567.46648800218, 35639.28721425609, 35958.64041359553, 36969.63030369662, 37195.07012324713, 31746.68253317437, 33506.83246583751, 33874.15314617154, 34008.829955850066, 34073.65926340705, 24460.266192014267, 25343.61984570196, 25502.0, 25507.46955182695, 25555.505834737443], "value": 17288.408530122637, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.83445532282815, 372.30750803505475, 375.1109869609027, 377.65851719340066, 388.72206372443713, 16161.676766464678, 17445.38941137059, 17702.380416685417, 17842.82157178428, 18013.7297940531, 11707.356095414749, 15614.141222232802, 16440.0, 16570.75143872843, 17195.0, 4507.166174257764, 4666.556677115668, 4686.953130468686, 4707.1762441572755, 4715.0, 3500.404931161696, 4627.8148874045, 5189.870253243661, 5468.781248750065, 5476.04169270378, 5490.505854473096, 5495.0, 5500.669959802404, 5504.119340905456, 5516.475934786189, 5243.082460569385, 5458.836234912959, 5460.754266058037, 5516.806911758089, 5518.724063796814, 5218.947810521922, 5229.686218826882, 5232.189010703347, 5256.421793602701, 5276.81531146408, 11664.708382290426, 12331.136820422575, 12334.50661973529, 12343.62969110919, 12371.072169587316, 1869.0843480384567, 1943.922243110288, 2003.5291706448972, 2101.980539438371, 2255.9548809023727, 8559.443636163629, 8667.089955554638, 8804.251638610725, 8854.690085847029, 9254.768630784285, 1661.6593598312438, 1665.1258089503108, 1683.9073850938194, 1700.6598680263874, 1735.2538408484347, 62935.370646293406, 64842.675786621236, 66461.33538664647, 67801.32198677999, 67973.66013169903, 9759.609615615296, 9776.811969816263, 9825.705228843146, 9984.800303994025, 10128.189744820396, 13655.112417692819, 13687.657808554866, 13722.794158087636, 13778.379972901244, 13788.655283617989, 7365.558066516026, 7400.370968467633, 7441.962790186014, 7571.659275332623, 7597.3162415382885, 7064.08166938305, 7135.8572828544175, 7173.0675012248075, 7179.748708795271, 7282.817929551804, 4239.957600424018, 4272.060146767706, 4290.141971605692, 4296.398504209413, 4371.082072764755, 1531.4410240262446, 1639.7376419773018, 1643.6137507685685, 1791.57002319445, 1863.7483939668243, 855.5337341149088, 907.8547432410915, 941.5998200764784, 951.4338968313842, 960.3277705606104, 16284.918575407048, 16884.746728799077, 16962.982221066777, 17201.311947521957, 17365.131743412778, 863.7192912303526, 885.0927799006071, 918.8575770755543, 922.2437601166979, 930.432436213909, 9312.255019598417, 9425.90574094264, 9477.147056764925, 9662.613495460102, 9797.657082002095, 388246.0, 390628.0, 408925.0, 412256.0, 413054.0, 73476.63261683658, 75528.62235688786, 76506.0, 76893.6155319231, 77100.22899771042, 923.1414784250711, 924.7688077980371, 925.6066171876926, 934.2759361494896, 940.2900809888628, 13915.304234788018, 14624.70750584961, 14905.850941490446, 15122.697546048797, 15444.30500627452, 36386.27227455489, 37092.25815483729, 37272.0, 38489.0, 39388.60611393849, 48508.846924951176, 49139.0, 49944.50055499544, 50720.23919641135, 51125.744371277906, 7687.88468172989, 7943.4042446817875, 7983.20167983197, 7984.24149705777, 8019.198080191934, 8657.091005444337, 10815.0, 11475.196736228383, 11769.936704118198, 12416.689582760504, 10064.446455444728, 10625.22479319013, 10672.30630009047, 10876.728081798019, 11071.1696622752, 5234.633575649668, 10675.626353077605, 10832.295900766425, 10955.178361622751, 11120.944395277971, 10289.53697083648, 10469.895301046892, 10512.894871051498, 10547.57809687604, 10703.411312377893, 6681.164854393201, 6911.481638877004, 6973.5118541701595, 7079.8938015930835, 7627.0, 7332.890006650011, 8835.381523293565, 9898.752531186778, 9917.752056198653, 10223.233257505568], "value": 7990.950669983247, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.1456282542001, 1406.2858682742308, 1472.6760112775187, 1670.1565709316794, 1671.9916400417997, 6805.35349141832, 7447.292507211813, 7448.478606497534, 7938.3649308055365, 7985.999999999993, 7568.432367572426, 7747.1090824555195, 7817.374610031198, 7824.843503129934, 7831.960840195791, 2224.7997680208778, 2241.8766967816764, 2252.560750653623, 2260.446190683285, 2274.1130958926033, 2195.714557107574, 2198.505336299336, 2238.708967834187, 2245.3264020793695, 2245.4161917901383, 2217.412385717778, 2231.3529076567775, 2243.3270018994317, 2246.3148739634403, 2249.268987579035, 2113.788621137889, 2126.170793390579, 2132.0832042221837, 2132.9040193191345, 2136.935891923245, 2129.0419311309815, 2132.9786702132933, 2139.3368055902565, 2156.1698745982753, 2158.028887000856, 7793.610319484003, 7918.80202994924, 7923.207679232089, 7938.325242354407, 7965.800854978614, 4585.449746030465, 4697.483276839579, 4698.882527936795, 4703.294505824119, 4716.882077948078, 2980.2549362659333, 3049.9390012199856, 3169.4453470642547, 3181.761367897394, 3183.2996740717003, 937.5124935033745, 978.6738968697455, 989.7080361293364, 996.970090897267, 997.6159178716247, 10508.632197873114, 10529.157667386591, 10532.052115309581, 10546.209034322457, 10558.155347572176, 4089.6932730045364, 4249.787510624518, 4266.125444283976, 4285.871423857289, 4299.484061912528, 8957.283417326598, 9021.50381728998, 9029.0, 9030.051844556227, 9035.36752427337, 4704.29435584665, 4769.880752981203, 4776.068666609977, 4782.234842425195, 4798.04039192163, 3510.4909788081095, 4094.3653733671326, 4238.788060596958, 4273.572642735701, 4369.257226271541, 3610.6389361063684, 3631.3463576555946, 3677.742558020913, 3758.981205093957, 3765.3222419964122, 1200.8018676918384, 1211.5638370186725, 1229.5450683247077, 1231.2735486063266, 1235.5243231355992, 828.4780588229377, 840.0801122770556, 845.6194712379331, 852.3522123186423, 854.0136142755127, 5105.770240339194, 5174.896502069938, 5219.739013049409, 5326.0, 5361.946380536145, 376.3977635782726, 380.7886622924304, 383.97504162229365, 384.83067450321767, 385.5893473450822, 3635.9091022724115, 3695.57500887396, 3700.7224458165747, 3774.3206222880144, 3777.33896568105, 9196.678116265899, 9501.382410143318, 9587.568559414844, 9613.90386096144, 9636.71089867305, 9438.90561094394, 9453.66912158085, 9468.857967130498, 9471.952640236892, 9503.239740820718, 7188.820279493055, 7324.523905946203, 7368.15266244378, 7411.036565246483, 7423.44324175689, 5091.439941606494, 5259.973700131475, 5333.413324534221, 5341.679499230058, 5482.698451585042, 8497.74506764798, 8688.82622347537, 8829.0, 8842.557872106498, 9018.458892466473, 8786.692465763923, 9040.050794666728, 9042.457452552868, 9090.36367454272, 9098.181163695299, 6133.662648554372, 6654.866902662016, 6789.1174147360525, 6925.27284635106, 6960.0, 7664.770056898302, 7665.501742386727, 7670.0, 7677.270659287359, 7733.961330193313, 6487.870242595027, 6565.179352580927, 6604.207495100619, 6640.800775976729, 6770.763023294161, 6378.521610879296, 6396.10454536356, 6468.353164683682, 6504.707288172138, 6642.734290628514, 6244.968775156095, 6287.371262873676, 6288.056791481315, 6307.369263073656, 6319.715612797527, 4501.212287849678, 4569.771511424482, 4593.678442509126, 4606.470255920612, 4634.884127896829, 4412.536683648171, 4515.14212299662, 4530.977345113253, 4540.909181816279, 4664.370310008106], "value": 4073.515847396244, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.4032853635656, 297.8153544802223, 298.59540322862523, 300.07576663875255, 304.35780503138386, 5010.945512339932, 5065.924011139836, 5093.33786607741, 5103.413107492639, 5152.562032227256, 4986.376702912136, 4990.675606085602, 5024.145895197816, 5059.671121377108, 5064.620153488485, 3961.0, 3993.880183594497, 4006.7395619284725, 4011.759294442328, 4017.6785857131504, 3822.73240873139, 3884.32024395731, 3935.2129574085156, 3998.360262358023, 4021.939670904939, 3811.2187001664593, 3870.4194370844457, 3871.2064026874564, 3877.941830872539, 3878.55396629387, 3887.7278590498536, 3899.78551179685, 3912.8826135215704, 3914.0, 3928.2732694451333, 3249.6750324967315, 3315.9057511021306, 3449.189440481485, 3454.9309013819834, 3455.8617655293756, 4850.951490485085, 4873.853784386474, 4874.829380971649, 4889.217725163957, 4891.633127515415, 4451.15126319156, 4500.302453119772, 4506.5493450655, 4511.458624964992, 4522.34426008227, 5020.548150666421, 5269.841904742864, 5279.340082489689, 5280.49835265653, 5299.152135658276, 3628.711807308394, 3649.288388764192, 3657.1588534636917, 3674.026383008505, 3713.3687273163355, 5430.343745157726, 5520.806771762969, 5535.612507124543, 5549.972250138764, 5563.496426608042, 3554.2713743682484, 3699.7595156314756, 3801.125741079567, 3801.163743976321, 3805.1818858945458, 3794.5446546414605, 3804.6575808176844, 3809.3714537101623, 3831.9616803831605, 3836.9808150959625, 4395.890102747457, 4397.944493321644, 4398.340248962617, 4402.613176849282, 4404.810701110746, 5155.304033955443, 5297.728545149136, 5306.177542480922, 5317.893642127213, 5338.359396872323, 1290.3677198173016, 1310.7706151423654, 1313.1464548043848, 1313.39583791457, 1314.4873499335267, 819.9877001844977, 830.7590798668318, 844.408290372652, 845.3659755183612, 845.6448291717494, 4132.318167502329, 4137.2552940470405, 4140.565240649748, 4156.58434156588, 4168.43726096973, 4816.686915350561, 4829.372181616438, 4848.393950756155, 4906.699724572991, 4913.140200464904, 4089.7750623715983, 4097.651699605567, 4125.494194618943, 4200.768957707294, 4210.2842516772225, 2511.5102555001963, 2527.4945010997876, 2585.90949316773, 2768.764655004307, 2852.3867368515453, 5071.518205770446, 5077.416097148875, 5088.949110508847, 5100.38795344561, 5108.974455127701, 5512.614117011851, 5573.359063707644, 5578.665280083127, 5583.35791383996, 5585.413531579125, 4850.514948505192, 5063.417706963746, 5074.289599456005, 5082.949170508247, 5134.358205224347, 5482.972585137049, 5486.862828429321, 5510.972445137749, 5516.779328826802, 5520.365158006881, 5385.46145385474, 5390.97304513475, 5407.594430417813, 5409.648372855751, 5418.593605479684, 4792.496787837227, 5114.974425127851, 5135.486451354835, 5136.666116702402, 5152.407473140487, 3717.4609681596557, 3742.176721121349, 3750.0249935016545, 3756.398976163801, 3765.1151979285396, 5484.698341591251, 5485.561155107662, 5495.313085864267, 5502.862428439321, 5515.862103447446, 5007.324011258579, 5268.367795864521, 5288.81489147878, 5304.416514183514, 5306.575473962151, 5286.39206491243, 5322.414534401135, 5332.440093790096, 5368.43631418711, 5371.0, 5159.638825282194, 5176.896462070813, 5296.2055691646565, 5298.059576934838, 5302.231176479312, 5279.568280617629, 5343.732813359395, 5351.705656188791, 5380.354357477127, 5412.350517937715, 5242.344706911636, 5271.998320319127, 5276.841694749163, 5293.576513878804, 5320.2817619620855], "value": 3911.411835204434, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.5005071424646, 712.9287071292871, 716.5270921192011, 723.5694761616837, 748.4947660329276, 12532.749345013095, 13493.730125397498, 13525.120867143653, 13536.1201521901, 13545.322733863291, 13311.600651980432, 13439.462421503153, 13479.595612131627, 13522.526711565097, 13535.255560944144, 616.9691515424222, 768.9846203075936, 791.9722809701661, 793.5199204481293, 794.253401802304, 775.5463054113351, 783.7687882074802, 784.0356361675115, 784.352908850198, 790.0795573157264, 831.8752187171912, 833.3541505333354, 833.5748768128268, 834.0700119366893, 835.7701632051204, 824.4270232188601, 828.188375392119, 829.4898637338054, 830.73001274586, 831.966721331146, 606.6784604159758, 606.7178761875749, 607.3895734786555, 607.714374244109, 607.872346807171, 13438.731225375535, 13467.393967271497, 13490.797638035438, 13491.392887319997, 13503.25732084735, 12081.275123492618, 13024.782895487317, 13426.91882758174, 13553.0, 14021.85978140226, 9978.151857092156, 10278.359802316318, 10330.89669103307, 10333.58665653373, 10356.326838755456, 3306.272620023591, 3341.899743007714, 3346.7322614190807, 3353.312570922955, 3428.8114153721535, 58424.415755842325, 59528.70235648794, 59724.70137649327, 59738.40261597372, 59759.402405975816, 10668.519916603771, 10676.145908327315, 10697.946510267555, 10798.892011079788, 10801.351918884891, 19428.417147485598, 19598.510037249183, 19616.11727472267, 19626.411207663507, 20067.29764458237, 6965.547239429421, 7093.680784364716, 7102.0, 7252.166000909858, 7391.6673749681395, 3763.4354846773203, 3833.0, 3842.9615703842605, 3849.5188101487315, 3863.459115723801, 2864.598956146141, 2954.5568164775027, 2983.1498023063323, 2994.7454466370605, 2998.895038673636, 489.2172523961633, 489.6963882392868, 494.9406071271471, 501.15555289337584, 505.6081536809003, 541.934967803866, 550.2022068001414, 565.2566874559941, 572.1446437575768, 597.8834127345126, 7877.842443151219, 7938.166492518318, 8149.877751833727, 8226.547539885363, 8284.958575207085, 493.0090518058656, 534.7059117485445, 561.6742289472096, 565.4958257479198, 565.9490645841812, 3950.4469374287623, 4069.91860162801, 4074.083331250445, 4128.1330920506425, 4147.564505726855, 78556.82164767533, 90454.54772726225, 93517.5324123375, 94361.5281923586, 95890.5205473982, 81712.18287817165, 81878.59060704659, 82062.58968705118, 82636.17363826405, 82690.17309826825, 43441.34837977433, 45106.548934510894, 72117.63941180261, 74799.0, 75731.0525160186, 7730.922690773245, 7813.648385822538, 7825.608719564113, 7844.686212551663, 8020.0, 43842.0, 44093.33859992167, 45079.54920450754, 45482.77258613686, 45503.54496454993, 61701.0, 62757.0, 63371.366286336546, 63693.0, 64030.0, 10472.633457828939, 10552.947235263775, 10575.0, 10664.893351066701, 11087.33475991443, 10665.89334106649, 10723.19576031785, 10755.462226888469, 10819.945900270763, 11036.724081898017, 9511.857322140035, 9694.175995040501, 9756.756081098029, 9841.95079024629, 9873.40759554429, 9774.218062554837, 9927.652532161339, 9948.602055917972, 10163.593456261668, 10274.640387586398, 9679.758006049906, 9703.514824258618, 9751.3661611995, 9865.309428340235, 9947.801043978936, 8496.660133594587, 8576.828463430822, 8817.338699597427, 8826.5586720665, 8882.200601945857, 8774.473531588124, 9244.168024877794, 9286.257099431894, 9373.343865929592, 9382.202512786216], "value": 6377.130748671092, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1591.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 109.0, 115.0, 114.0, 114.0, 116.0, 114.0, 116.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 131.0, 170.0, 178.0, 134.0, 167.0, 161.0, 139.0, 183.0, 135.0], "value": 156.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 179.0, 164.0, 162.0, 163.0, 179.0, 164.0, 163.0, 165.0], "value": 166.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 158.0, 77.0, 77.0, 76.0, 78.0, 159.0, 76.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 138.0, 87.0, 89.0, 87.0, 139.0, 88.0, 86.0, 134.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 119.0, 120.0, 118.0, 119.0, 119.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 149.0, 147.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 82.0, 83.0, 85.0, 83.0, 84.0, 84.0, 100.0, 85.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 134.0, 137.0, 140.0, 131.0, 136.0, 137.0, 144.0, 136.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 176.0, 177.0, 178.0, 173.0, 180.0, 176.0, 176.0, 176.0, 177.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 73.0, 67.0, 71.0, 69.0, 69.0, 73.0, 67.0], "value": 69.3, "unit": "score"}]}]} 07:42:45 INFO - Return code: 0 07:42:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:42:45 ERROR - # TBPL SUCCESS # 07:42:45 INFO - Running post-action listener: _resource_record_post_action 07:42:45 INFO - ##### 07:42:45 INFO - ##### Finished run-tests step (success) 07:42:45 INFO - ##### 07:42:45 INFO - Running post-run listener: _resource_record_post_run 07:42:45 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 81920; Write bytes: 548192256; Read time: 508; Write time: 511660 07:42:45 INFO - TinderboxPrint: CPU usage
13.5% 07:42:45 INFO - TinderboxPrint: I/O read bytes / time
81,920 / 508 07:42:45 INFO - TinderboxPrint: I/O write bytes / time
548,192,256 / 511,660 07:42:45 INFO - TinderboxPrint: CPU idle
8,268.5 (86.5%) 07:42:45 INFO - TinderboxPrint: CPU user
1,231.7 (12.9%) 07:42:45 INFO - TinderboxPrint: Swap in / out
0 / 0 07:42:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 252477440; Read time: 0; Write time: 225296 07:42:45 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 81920; Write bytes: 295714816; Read time: 508; Write time: 286364 07:42:46 INFO - Running post-run listener: _upload_blobber_files 07:42:46 INFO - Blob upload gear active. 07:42:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:42:46 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 07:42:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:42:46 INFO - (blobuploader) - INFO - Open directory for files ... 07:42:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:42:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:42:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:42:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:42:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:42:51 INFO - (blobuploader) - INFO - Done attempting. 07:42:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:42:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:42:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:42:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:42:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:42:51 INFO - (blobuploader) - INFO - Done attempting. 07:42:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:42:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:42:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:42:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:42:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:42:52 INFO - (blobuploader) - INFO - Done attempting. 07:42:52 INFO - (blobuploader) - INFO - Iteration through files over. 07:42:52 INFO - Return code: 0 07:42:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:42:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:42:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd7b0bcc2090c2150f92b407c9970529b23fadb2f4124d575e800dac7e464fa625dbf1a31ca3bc86f676f1bf4c9beba4202d58f5883c9e378d35197e502586d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a95edf882a906aba2716f154eaf1595baa8e5a9d58c06f8abb4ffbea5ddb87b94ca2e3b2564f0622f63fcab2567504b09a646258459489774d09ece1384310be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de024b1cdc8a436c3fa3b484c7545c82e1d8060c6fb1e3e65c3f4f5f11e3895713332439818d7c8b6dc2a33a081762b00653f2d3d37f78292c931901a07dca8c"} 07:42:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:42:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:42:52 INFO - Contents: 07:42:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd7b0bcc2090c2150f92b407c9970529b23fadb2f4124d575e800dac7e464fa625dbf1a31ca3bc86f676f1bf4c9beba4202d58f5883c9e378d35197e502586d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a95edf882a906aba2716f154eaf1595baa8e5a9d58c06f8abb4ffbea5ddb87b94ca2e3b2564f0622f63fcab2567504b09a646258459489774d09ece1384310be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de024b1cdc8a436c3fa3b484c7545c82e1d8060c6fb1e3e65c3f4f5f11e3895713332439818d7c8b6dc2a33a081762b00653f2d3d37f78292c931901a07dca8c"} 07:42:52 INFO - Running post-run listener: copy_logs_to_upload_dir 07:42:52 INFO - Copying logs to upload dir... 07:42:52 INFO - mkdir: /builds/slave/test/build/upload/logs 07:42:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.775788 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-24 07:42:51.884114) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 07:42:51.887818) ========= 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=31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd7b0bcc2090c2150f92b407c9970529b23fadb2f4124d575e800dac7e464fa625dbf1a31ca3bc86f676f1bf4c9beba4202d58f5883c9e378d35197e502586d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a95edf882a906aba2716f154eaf1595baa8e5a9d58c06f8abb4ffbea5ddb87b94ca2e3b2564f0622f63fcab2567504b09a646258459489774d09ece1384310be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de024b1cdc8a436c3fa3b484c7545c82e1d8060c6fb1e3e65c3f4f5f11e3895713332439818d7c8b6dc2a33a081762b00653f2d3d37f78292c931901a07dca8c"} build_url:https://queue.taskcluster.net/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/P326_xjBRzOgN_2tVc84Ug/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd7b0bcc2090c2150f92b407c9970529b23fadb2f4124d575e800dac7e464fa625dbf1a31ca3bc86f676f1bf4c9beba4202d58f5883c9e378d35197e502586d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a95edf882a906aba2716f154eaf1595baa8e5a9d58c06f8abb4ffbea5ddb87b94ca2e3b2564f0622f63fcab2567504b09a646258459489774d09ece1384310be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de024b1cdc8a436c3fa3b484c7545c82e1d8060c6fb1e3e65c3f4f5f11e3895713332439818d7c8b6dc2a33a081762b00653f2d3d37f78292c931901a07dca8c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 07:42:51.916776) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 07:42:51.917326) ========= 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=31acecf42b6a79ec49471d4a000001bb-1466778130.259355-176535826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 07:42:51.999168) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 07:42:51.999998) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 07:42:52.000523) ========= ========= Total master_lag: 0.18 =========