builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1466497938.72 results: success (0) buildid: 20160621003900 builduid: a352f56d2eb34dc3ba6f7dc114a2310e revision: 21a0421ca9b0e39a28b1ab1875b6ac33f06f23da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:18.721655) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:18.722018) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:18.722287) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:18.795519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:18.795774) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 01:32:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-21 01:32:18 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132983 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:18.946564) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:18.946842) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017883 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:18.999838) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:19.000138) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 21a0421ca9b0e39a28b1ab1875b6ac33f06f23da --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 21a0421ca9b0e39a28b1ab1875b6ac33f06f23da --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=2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 01:32:19,086 truncating revision to first 12 chars 2016-06-21 01:32:19,086 Setting DEBUG logging. 2016-06-21 01:32:19,086 attempt 1/10 2016-06-21 01:32:19,086 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/21a0421ca9b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 01:32:19,378 unpacking tar archive at: fx-team-21a0421ca9b0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679818 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:19.695420) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:19.695696) ========= script_repo_revision: 21a0421ca9b0e39a28b1ab1875b6ac33f06f23da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:19.696050) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:19.696311) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:19.706314) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-06-21 01:32:19.706589) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:32:19 INFO - MultiFileLogger online at 20160621 01:32:19 in /builds/slave/test 01:32:19 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 01:32:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:32:19 INFO - {'append_to_log': False, 01:32:19 INFO - 'base_work_dir': '/builds/slave/test', 01:32:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:32:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:32:19 INFO - 'branch': 'Fx-Team-Non-PGO', 01:32:19 INFO - 'buildbot_json_path': 'buildprops.json', 01:32:19 INFO - 'config_files': ('talos/linux_config.py',), 01:32:19 INFO - 'default_actions': ('clobber', 01:32:19 INFO - 'read-buildbot-config', 01:32:19 INFO - 'download-and-extract', 01:32:19 INFO - 'populate-webroot', 01:32:19 INFO - 'create-virtualenv', 01:32:19 INFO - 'install', 01:32:19 INFO - 'run-tests'), 01:32:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:32:19 INFO - 'download_minidump_stackwalk': True, 01:32:19 INFO - 'download_symbols': 'ondemand', 01:32:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:32:19 INFO - 'tooltool.py': '/tools/tooltool.py', 01:32:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:32:19 INFO - '/tools/misc-python/virtualenv.py')}, 01:32:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:32:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:32:19 INFO - 'installer_path': 'installer.exe', 01:32:19 INFO - 'log_level': 'info', 01:32:19 INFO - 'log_name': 'talos', 01:32:19 INFO - 'log_to_console': True, 01:32:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:32:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:32:19 INFO - 'opt_config_files': (), 01:32:19 INFO - 'pip_index': False, 01:32:19 INFO - 'sps_profile': False, 01:32:19 INFO - 'sps_profile_interval': 0, 01:32:19 INFO - 'suite': 'dromaeojs-e10s', 01:32:19 INFO - 'system_bits': '32', 01:32:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:32:19 INFO - 'title': 'talos-linux64-ix-012', 01:32:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:32:19 INFO - 'use_talos_json': True, 01:32:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:32:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:32:19 INFO - 'work_dir': 'build'} 01:32:19 INFO - ##### 01:32:19 INFO - ##### Running clobber step. 01:32:19 INFO - ##### 01:32:19 INFO - Running pre-action listener: _resource_record_pre_action 01:32:19 INFO - Running main action method: clobber 01:32:19 INFO - rmtree: /builds/slave/test/build 01:32:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:32:20 INFO - Running post-action listener: _resource_record_post_action 01:32:20 INFO - ##### 01:32:20 INFO - ##### Finished clobber step (success) 01:32:20 INFO - ##### 01:32:20 INFO - ##### 01:32:20 INFO - ##### Running read-buildbot-config step. 01:32:20 INFO - ##### 01:32:20 INFO - Running pre-action listener: _resource_record_pre_action 01:32:20 INFO - Running main action method: read_buildbot_config 01:32:20 INFO - Using buildbot properties: 01:32:20 INFO - { 01:32:20 INFO - "project": "", 01:32:20 INFO - "product": "firefox", 01:32:20 INFO - "script_repo_revision": "production", 01:32:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:32:20 INFO - "repository": "", 01:32:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 01:32:20 INFO - "buildid": "20160621003900", 01:32:20 INFO - "pgo_build": "False", 01:32:20 INFO - "basedir": "/builds/slave/test", 01:32:20 INFO - "buildnumber": 1599, 01:32:20 INFO - "slavename": "talos-linux64-ix-012", 01:32:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:32:20 INFO - "platform": "ubuntu64_hw", 01:32:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:32:20 INFO - "branch": "fx-team", 01:32:20 INFO - "repo_path": "integration/fx-team", 01:32:20 INFO - "revision": "21a0421ca9b0e39a28b1ab1875b6ac33f06f23da", 01:32:20 INFO - "stage_platform": "linux64", 01:32:20 INFO - "builduid": "a352f56d2eb34dc3ba6f7dc114a2310e", 01:32:20 INFO - "slavebuilddir": "test" 01:32:20 INFO - } 01:32:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:32:20 INFO - Running post-action listener: _resource_record_post_action 01:32:20 INFO - ##### 01:32:20 INFO - ##### Finished read-buildbot-config step (success) 01:32:20 INFO - ##### 01:32:20 INFO - ##### 01:32:20 INFO - ##### Running download-and-extract step. 01:32:20 INFO - ##### 01:32:20 INFO - Running pre-action listener: _resource_record_pre_action 01:32:20 INFO - Running main action method: download_and_extract 01:32:20 INFO - mkdir: /builds/slave/test/build/tests 01:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:20 INFO - https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:32:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:32:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:32:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:29 INFO - Downloaded 1361 bytes. 01:32:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:32:29 INFO - Using the following test package requirements: 01:32:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:32:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:32:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:32:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:29 INFO - u'jsshell-linux-x86_64.zip'], 01:32:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:32:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:32:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:32:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:32:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:32:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:32:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:32: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')]} 01:32:29 INFO - https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:32:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:32:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:32:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:44 INFO - Downloaded 22654960 bytes. 01:32:44 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'] 01:32:44 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 01:32:45 INFO - Return code: 0 01:32:45 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 01:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:45 INFO - https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:32:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:32:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:32:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:46 INFO - Downloaded 22654960 bytes. 01:32:46 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'] 01:32:46 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 01:32:47 INFO - Return code: 0 01:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:47 INFO - https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:32:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:32:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:32:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:48 INFO - Downloaded 14405384 bytes. 01:32:48 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'] 01:32:48 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 01:32:49 INFO - Return code: 0 01:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:49 INFO - https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:32:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:32:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:32:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:50 INFO - Downloaded 56233053 bytes. 01:32:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:32:50 INFO - mkdir: /builds/slave/test/properties 01:32:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:32:50 INFO - Writing to file /builds/slave/test/properties/build_url 01:32:50 INFO - Contents: 01:32:50 INFO - build_url:https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:32:51 INFO - Running post-action listener: _resource_record_post_action 01:32:51 INFO - Running post-action listener: set_extra_try_arguments 01:32:51 INFO - ##### 01:32:51 INFO - ##### Finished download-and-extract step (success) 01:32:51 INFO - ##### 01:32:51 INFO - ##### 01:32:51 INFO - ##### Running populate-webroot step. 01:32:51 INFO - ##### 01:32:51 INFO - Running pre-action listener: _resource_record_pre_action 01:32:51 INFO - Running main action method: populate_webroot 01:32:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:32:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:32:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:32:51 INFO - '--tppagecycles', 01:32:51 INFO - '7'], 01:32:51 INFO - 'tests': ['tsvgm']}}, 01:32:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:32:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:32:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:32:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:32:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:32:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:32:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:51 INFO - 'talos_options': ['--disable-e10s'], 01:32:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:32:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:32:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:51 INFO - 'talos_options': ['--disable-e10s'], 01:32:51 INFO - 'tests': ['damp', 'tps']}, 01:32:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:51 INFO - 'tests': ['damp', 'tps']}, 01:32:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:32:51 INFO - 'tests': ['dromaeo_dom']}, 01:32:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:32:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:32:51 INFO - 'tests': ['basic_compositor_video']}, 01:32:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:32:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:32:51 INFO - 'tests': ['a11yr', 01:32:51 INFO - 'ts_paint', 01:32:51 INFO - 'tpaint', 01:32:51 INFO - 'sessionrestore', 01:32:51 INFO - 'sessionrestore_no_auto_restore', 01:32:51 INFO - 'tabpaint']}, 01:32:51 INFO - 'other-e10s': {'tests': ['a11yr', 01:32:51 INFO - 'ts_paint', 01:32:51 INFO - 'tpaint', 01:32:51 INFO - 'sessionrestore', 01:32:51 INFO - 'sessionrestore_no_auto_restore', 01:32:51 INFO - 'tabpaint']}, 01:32:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:32:51 INFO - 'ts_paint', 01:32:51 INFO - 'tpaint', 01:32:51 INFO - 'sessionrestore', 01:32:51 INFO - 'sessionrestore_no_auto_restore', 01:32:51 INFO - 'tabpaint']}, 01:32:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:32:51 INFO - 'ts_paint', 01:32:51 INFO - 'tpaint', 01:32:51 INFO - 'sessionrestore', 01:32:51 INFO - 'sessionrestore_no_auto_restore', 01:32:51 INFO - 'tabpaint']}, 01:32:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:32:51 INFO - 'tests': ['a11yr', 01:32:51 INFO - 'ts_paint', 01:32:51 INFO - 'tpaint', 01:32:51 INFO - 'sessionrestore', 01:32:51 INFO - 'sessionrestore_no_auto_restore', 01:32:51 INFO - 'tabpaint']}, 01:32:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:32:51 INFO - 'tests': ['a11yr', 01:32:51 INFO - 'ts_paint', 01:32:51 INFO - 'tpaint', 01:32:51 INFO - 'sessionrestore', 01:32:51 INFO - 'sessionrestore_no_auto_restore', 01:32:51 INFO - 'tabpaint']}, 01:32:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:32:51 INFO - 'tests': ['tsvgx', 01:32:51 INFO - 'tsvgr_opacity', 01:32:51 INFO - 'tart', 01:32:51 INFO - 'tscrollx', 01:32:51 INFO - 'cart']}, 01:32:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:32:51 INFO - 'tsvgr_opacity', 01:32:51 INFO - 'tart', 01:32:51 INFO - 'tscrollx', 01:32:51 INFO - 'cart']}, 01:32:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:51 INFO - 'talos_options': ['--disable-e10s'], 01:32:51 INFO - 'tests': ['tp5o']}, 01:32:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:51 INFO - 'tests': ['tp5o']}, 01:32:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:51 INFO - 'talos_options': ['--disable-e10s', 01:32:51 INFO - '--xperf_path', 01:32:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:32:51 INFO - 'tests': ['tp5n']}, 01:32:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:51 INFO - 'talos_options': ['--xperf_path', 01:32:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:32:51 INFO - 'tests': ['tp5n']}}, 01:32:51 INFO - 'talos.zip': {'path': '', 01:32:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:32:51 INFO - Running post-action listener: _resource_record_post_action 01:32:51 INFO - ##### 01:32:51 INFO - ##### Finished populate-webroot step (success) 01:32:51 INFO - ##### 01:32:51 INFO - ##### 01:32:51 INFO - ##### Running create-virtualenv step. 01:32:51 INFO - ##### 01:32:51 INFO - Running pre-action listener: _resource_record_pre_action 01:32:51 INFO - Running main action method: create_virtualenv 01:32:51 INFO - Creating virtualenv /builds/slave/test/build/venv 01:32:51 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 01:32:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:32:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:32:51 INFO - Using real prefix '/usr' 01:32:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:32:51 INFO - Installing distribute.............................................................................................................................................................................................done. 01:32:53 INFO - Installing pip.................done. 01:32:53 INFO - Return code: 0 01:32:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:53 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 0x7f42bd861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1c0>, '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 0x100b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', '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 01:32:53 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 01:32:53 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 01:32:53 INFO - Using env: {'DISPLAY': ':0', 01:32:53 INFO - 'HOME': '/home/cltbld', 01:32:53 INFO - 'LANG': 'en_US.UTF-8', 01:32:53 INFO - 'LANGUAGE': 'en_US:en', 01:32:53 INFO - 'LOGNAME': 'cltbld', 01:32:53 INFO - 'MAIL': '/var/mail/cltbld', 01:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:53 INFO - 'MOZ_NO_REMOTE': '1', 01:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:53 INFO - 'NO_EM_RESTART': '1', 01:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:53 INFO - 'PWD': '/builds/slave/test', 01:32:53 INFO - 'SHELL': '/bin/bash', 01:32:53 INFO - 'SHLVL': '1', 01:32:53 INFO - 'TERM': 'linux', 01:32:53 INFO - 'TMOUT': '86400', 01:32:53 INFO - 'USER': 'cltbld', 01:32:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', 01:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:53 INFO - '_': '/tools/buildbot/bin/python'} 01:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:54 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 01:32:54 INFO - Cleaning up... 01:32:54 INFO - Return code: 0 01:32:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f42bd861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1c0>, '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 0x100b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', '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 01:32:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:32:54 INFO - Using env: {'DISPLAY': ':0', 01:32:54 INFO - 'HOME': '/home/cltbld', 01:32:54 INFO - 'LANG': 'en_US.UTF-8', 01:32:54 INFO - 'LANGUAGE': 'en_US:en', 01:32:54 INFO - 'LOGNAME': 'cltbld', 01:32:54 INFO - 'MAIL': '/var/mail/cltbld', 01:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:54 INFO - 'MOZ_NO_REMOTE': '1', 01:32:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:54 INFO - 'NO_EM_RESTART': '1', 01:32:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:54 INFO - 'PWD': '/builds/slave/test', 01:32:54 INFO - 'SHELL': '/bin/bash', 01:32:54 INFO - 'SHLVL': '1', 01:32:54 INFO - 'TERM': 'linux', 01:32:54 INFO - 'TMOUT': '86400', 01:32:54 INFO - 'USER': 'cltbld', 01:32:54 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', 01:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:54 INFO - '_': '/tools/buildbot/bin/python'} 01:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:54 INFO - Downloading/unpacking psutil>=3.1.1 01:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:32:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:32:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:32:56 INFO - Installing collected packages: psutil 01:32:56 INFO - Running setup.py install for psutil 01:32:56 INFO - building 'psutil._psutil_linux' extension 01:32:56 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 01:32:56 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 01:32:56 INFO - building 'psutil._psutil_posix' extension 01:32:56 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 01:32:56 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 01:32:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:32:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:32:56 INFO - Successfully installed psutil 01:32:56 INFO - Cleaning up... 01:32:56 INFO - Return code: 0 01:32:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:56 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 0x7f42bd861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1c0>, '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 0x100b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', '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 01:32:56 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 01:32:56 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 01:32:56 INFO - Using env: {'DISPLAY': ':0', 01:32:56 INFO - 'HOME': '/home/cltbld', 01:32:56 INFO - 'LANG': 'en_US.UTF-8', 01:32:56 INFO - 'LANGUAGE': 'en_US:en', 01:32:56 INFO - 'LOGNAME': 'cltbld', 01:32:56 INFO - 'MAIL': '/var/mail/cltbld', 01:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:56 INFO - 'MOZ_NO_REMOTE': '1', 01:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:56 INFO - 'NO_EM_RESTART': '1', 01:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:56 INFO - 'PWD': '/builds/slave/test', 01:32:56 INFO - 'SHELL': '/bin/bash', 01:32:56 INFO - 'SHLVL': '1', 01:32:56 INFO - 'TERM': 'linux', 01:32:56 INFO - 'TMOUT': '86400', 01:32:56 INFO - 'USER': 'cltbld', 01:32:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', 01:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:56 INFO - '_': '/tools/buildbot/bin/python'} 01:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:32:58 INFO - Installing collected packages: mozsystemmonitor 01:32:58 INFO - Running setup.py install for mozsystemmonitor 01:32:59 INFO - Successfully installed mozsystemmonitor 01:32:59 INFO - Cleaning up... 01:32:59 INFO - Return code: 0 01:32:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:59 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 0x7f42bd861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1c0>, '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 0x100b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', '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 01:32:59 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 01:32:59 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 01:32:59 INFO - Using env: {'DISPLAY': ':0', 01:32:59 INFO - 'HOME': '/home/cltbld', 01:32:59 INFO - 'LANG': 'en_US.UTF-8', 01:32:59 INFO - 'LANGUAGE': 'en_US:en', 01:32:59 INFO - 'LOGNAME': 'cltbld', 01:32:59 INFO - 'MAIL': '/var/mail/cltbld', 01:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:59 INFO - 'MOZ_NO_REMOTE': '1', 01:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:59 INFO - 'NO_EM_RESTART': '1', 01:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:59 INFO - 'PWD': '/builds/slave/test', 01:32:59 INFO - 'SHELL': '/bin/bash', 01:32:59 INFO - 'SHLVL': '1', 01:32:59 INFO - 'TERM': 'linux', 01:32:59 INFO - 'TMOUT': '86400', 01:32:59 INFO - 'USER': 'cltbld', 01:32:59 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', 01:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:59 INFO - '_': '/tools/buildbot/bin/python'} 01:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:59 INFO - Downloading/unpacking jsonschema==2.5.1 01:32:59 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 01:32:59 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 01:32:59 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 01:32:59 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 01:32:59 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 01:32:59 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 01:33:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:33:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:01 INFO - Downloading functools32-3.2.3-2.tar.gz 01:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:33:01 INFO - warning: no files found matching '*.txt' 01:33:01 INFO - no previously-included directories found matching 'build' 01:33:01 INFO - no previously-included directories found matching 'dist' 01:33:01 INFO - no previously-included directories found matching '.git*' 01:33:01 INFO - Installing collected packages: jsonschema, functools32 01:33:01 INFO - Running setup.py install for functools32 01:33:01 INFO - warning: no files found matching '*.txt' 01:33:01 INFO - no previously-included directories found matching 'build' 01:33:01 INFO - no previously-included directories found matching 'dist' 01:33:01 INFO - no previously-included directories found matching '.git*' 01:33:01 INFO - Successfully installed jsonschema functools32 01:33:01 INFO - Cleaning up... 01:33:01 INFO - Return code: 0 01:33:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:01 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 0x7f42bd861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1c0>, '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 0x100b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', '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 01:33:01 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 01:33:01 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 01:33:01 INFO - Using env: {'DISPLAY': ':0', 01:33:01 INFO - 'HOME': '/home/cltbld', 01:33:01 INFO - 'LANG': 'en_US.UTF-8', 01:33:01 INFO - 'LANGUAGE': 'en_US:en', 01:33:01 INFO - 'LOGNAME': 'cltbld', 01:33:01 INFO - 'MAIL': '/var/mail/cltbld', 01:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:01 INFO - 'MOZ_NO_REMOTE': '1', 01:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:01 INFO - 'NO_EM_RESTART': '1', 01:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:01 INFO - 'PWD': '/builds/slave/test', 01:33:01 INFO - 'SHELL': '/bin/bash', 01:33:01 INFO - 'SHLVL': '1', 01:33:01 INFO - 'TERM': 'linux', 01:33:01 INFO - 'TMOUT': '86400', 01:33:01 INFO - 'USER': 'cltbld', 01:33:01 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', 01:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:01 INFO - '_': '/tools/buildbot/bin/python'} 01:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:01 INFO - Downloading/unpacking blobuploader==1.2.4 01:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:03 INFO - Downloading blobuploader-1.2.4.tar.gz 01:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:33:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:33:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:33:04 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 01:33:04 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 01:33:04 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 01:33:04 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 01:33:04 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 01:33:04 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 01:33:04 INFO - Downloading docopt-0.6.1.tar.gz 01:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:33:04 INFO - Installing collected packages: blobuploader, requests, docopt 01:33:04 INFO - Running setup.py install for blobuploader 01:33:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:33:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:33:04 INFO - Running setup.py install for requests 01:33:05 INFO - Running setup.py install for docopt 01:33:05 INFO - Successfully installed blobuploader requests docopt 01:33:05 INFO - Cleaning up... 01:33:05 INFO - Return code: 0 01:33:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:05 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 0x7f42bd861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1c0>, '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 0x100b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', '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 01:33:05 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 01:33:05 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 01:33:05 INFO - Using env: {'DISPLAY': ':0', 01:33:05 INFO - 'HOME': '/home/cltbld', 01:33:05 INFO - 'LANG': 'en_US.UTF-8', 01:33:05 INFO - 'LANGUAGE': 'en_US:en', 01:33:05 INFO - 'LOGNAME': 'cltbld', 01:33:05 INFO - 'MAIL': '/var/mail/cltbld', 01:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:05 INFO - 'MOZ_NO_REMOTE': '1', 01:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:05 INFO - 'NO_EM_RESTART': '1', 01:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:05 INFO - 'PWD': '/builds/slave/test', 01:33:05 INFO - 'SHELL': '/bin/bash', 01:33:05 INFO - 'SHLVL': '1', 01:33:05 INFO - 'TERM': 'linux', 01:33:05 INFO - 'TMOUT': '86400', 01:33:05 INFO - 'USER': 'cltbld', 01:33:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', 01:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:05 INFO - '_': '/tools/buildbot/bin/python'} 01:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:33:05 INFO - Running setup.py (path:/tmp/pip-ibSy8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:33:05 INFO - Running setup.py (path:/tmp/pip-PMAbNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:33:05 INFO - Running setup.py (path:/tmp/pip-7glhDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:33:05 INFO - Running setup.py (path:/tmp/pip-01UdZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:33:05 INFO - Running setup.py (path:/tmp/pip-rIl59e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:33:05 INFO - Running setup.py (path:/tmp/pip-V876Tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:33:05 INFO - Running setup.py (path:/tmp/pip-JZLpAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:33:05 INFO - Running setup.py (path:/tmp/pip-PijYlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:33:06 INFO - Running setup.py (path:/tmp/pip-hqeOV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:33:06 INFO - Running setup.py (path:/tmp/pip-RWTodA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:33:06 INFO - Running setup.py (path:/tmp/pip-3e5LOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:33:06 INFO - Running setup.py (path:/tmp/pip-JPGdTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:33:06 INFO - Running setup.py (path:/tmp/pip-Cf07Wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:33:06 INFO - Running setup.py (path:/tmp/pip-mtqGrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:06 INFO - Running setup.py (path:/tmp/pip-Gqi1SE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:33:06 INFO - Running setup.py (path:/tmp/pip-TlssZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:33:06 INFO - Running setup.py (path:/tmp/pip-TRyV5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:33:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:33:06 INFO - Running setup.py install for manifestparser 01:33:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:33:06 INFO - Running setup.py install for mozcrash 01:33:06 INFO - Running setup.py install for mozdebug 01:33:06 INFO - Running setup.py install for mozdevice 01:33:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:33:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:33:07 INFO - Running setup.py install for mozfile 01:33:07 INFO - Running setup.py install for mozhttpd 01:33:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:33:07 INFO - Running setup.py install for mozinfo 01:33:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:33:07 INFO - Running setup.py install for mozInstall 01:33:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:33:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:33:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:33:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:33:07 INFO - Running setup.py install for mozleak 01:33:07 INFO - Running setup.py install for mozlog 01:33:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:33:07 INFO - Running setup.py install for moznetwork 01:33:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:33:07 INFO - Running setup.py install for mozprocess 01:33:07 INFO - Running setup.py install for mozprofile 01:33:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:33:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:33:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:33:08 INFO - Running setup.py install for mozrunner 01:33:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:33:08 INFO - Running setup.py install for mozscreenshot 01:33:08 INFO - Running setup.py install for moztest 01:33:08 INFO - Running setup.py install for mozversion 01:33:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:33:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:33:08 INFO - Cleaning up... 01:33:08 INFO - Return code: 0 01:33:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:08 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 0x7f42bd861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1c0>, '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 0x100b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', '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 01:33:08 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 01:33:08 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 01:33:08 INFO - Using env: {'DISPLAY': ':0', 01:33:08 INFO - 'HOME': '/home/cltbld', 01:33:08 INFO - 'LANG': 'en_US.UTF-8', 01:33:08 INFO - 'LANGUAGE': 'en_US:en', 01:33:08 INFO - 'LOGNAME': 'cltbld', 01:33:08 INFO - 'MAIL': '/var/mail/cltbld', 01:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:08 INFO - 'MOZ_NO_REMOTE': '1', 01:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:08 INFO - 'NO_EM_RESTART': '1', 01:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:08 INFO - 'PWD': '/builds/slave/test', 01:33:08 INFO - 'SHELL': '/bin/bash', 01:33:08 INFO - 'SHLVL': '1', 01:33:08 INFO - 'TERM': 'linux', 01:33:08 INFO - 'TMOUT': '86400', 01:33:08 INFO - 'USER': 'cltbld', 01:33:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', 01:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:08 INFO - '_': '/tools/buildbot/bin/python'} 01:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:33:08 INFO - Running setup.py (path:/tmp/pip-YjZzTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:33:08 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)) 01:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:33:08 INFO - Running setup.py (path:/tmp/pip-ZrOrv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:33:08 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)) 01:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:33:08 INFO - Running setup.py (path:/tmp/pip-LbhTOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:33:08 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)) 01:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:33:08 INFO - Running setup.py (path:/tmp/pip-TJjb6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:33:08 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)) 01:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:33:08 INFO - Running setup.py (path:/tmp/pip-hBq3ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:33:09 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)) 01:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:33:09 INFO - Running setup.py (path:/tmp/pip-7wCMUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:33:09 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)) 01:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:33:09 INFO - Running setup.py (path:/tmp/pip-Hl_UtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:33:09 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)) 01:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:33:09 INFO - Running setup.py (path:/tmp/pip-q1pGev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:33:09 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)) 01:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:33:09 INFO - Running setup.py (path:/tmp/pip-DnCUGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:33:09 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)) 01:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:33:09 INFO - Running setup.py (path:/tmp/pip-X75ZdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:33:09 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)) 01:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:33:09 INFO - Running setup.py (path:/tmp/pip-VV_ky2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:33:09 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)) 01:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:33:09 INFO - Running setup.py (path:/tmp/pip-1eel2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:33:09 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)) 01:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:33:09 INFO - Running setup.py (path:/tmp/pip-SiOcww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:33:09 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)) 01:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:33:09 INFO - Running setup.py (path:/tmp/pip-STOjeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:33:09 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)) 01:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:09 INFO - Running setup.py (path:/tmp/pip-r8HeLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:09 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)) 01:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:33:09 INFO - Running setup.py (path:/tmp/pip-HBq6gD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:33:09 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)) 01:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:33:09 INFO - Running setup.py (path:/tmp/pip-ZStq_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:33:09 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)) 01:33:09 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)) 01:33:09 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)) 01:33:09 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)) 01:33:09 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)) 01:33:09 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)) 01:33:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:33:09 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 01:33:09 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 01:33:09 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 01:33:09 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 01:33:09 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 01:33:09 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 01:33:11 INFO - Downloading blessings-1.6.tar.gz 01:33:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:33:11 INFO - Installing collected packages: blessings 01:33:11 INFO - Running setup.py install for blessings 01:33:12 INFO - Successfully installed blessings 01:33:12 INFO - Cleaning up... 01:33:12 INFO - Return code: 0 01:33:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:33:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:33:12 INFO - Reading from file tmpfile_stdout 01:33:12 INFO - Current package versions: 01:33:12 INFO - argparse == 1.2.1 01:33:12 INFO - blessings == 1.6 01:33:12 INFO - blobuploader == 1.2.4 01:33:12 INFO - docopt == 0.6.1 01:33:12 INFO - functools32 == 3.2.3-2 01:33:12 INFO - jsonschema == 2.5.1 01:33:12 INFO - manifestparser == 1.1 01:33:12 INFO - mozInstall == 1.12 01:33:12 INFO - mozcrash == 0.17 01:33:12 INFO - mozdebug == 0.1 01:33:12 INFO - mozdevice == 0.48 01:33:12 INFO - mozfile == 1.2 01:33:12 INFO - mozhttpd == 0.7 01:33:12 INFO - mozinfo == 0.9 01:33:12 INFO - mozleak == 0.1 01:33:12 INFO - mozlog == 3.2 01:33:12 INFO - moznetwork == 0.27 01:33:12 INFO - mozprocess == 0.22 01:33:12 INFO - mozprofile == 0.28 01:33:12 INFO - mozrunner == 6.11 01:33:12 INFO - mozscreenshot == 0.1 01:33:12 INFO - mozsystemmonitor == 0.3 01:33:12 INFO - moztest == 0.7 01:33:12 INFO - mozversion == 1.4 01:33:12 INFO - psutil == 3.1.1 01:33:12 INFO - requests == 1.2.3 01:33:12 INFO - wsgiref == 0.1.2 01:33:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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')]} 01:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:12 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 0x7f42bd861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1c0>, '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 0x100b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', '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 01:33:12 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 01:33:12 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 01:33:12 INFO - Using env: {'DISPLAY': ':0', 01:33:12 INFO - 'HOME': '/home/cltbld', 01:33:12 INFO - 'LANG': 'en_US.UTF-8', 01:33:12 INFO - 'LANGUAGE': 'en_US:en', 01:33:12 INFO - 'LOGNAME': 'cltbld', 01:33:12 INFO - 'MAIL': '/var/mail/cltbld', 01:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:12 INFO - 'MOZ_NO_REMOTE': '1', 01:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:12 INFO - 'NO_EM_RESTART': '1', 01:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:12 INFO - 'PWD': '/builds/slave/test', 01:33:12 INFO - 'SHELL': '/bin/bash', 01:33:12 INFO - 'SHLVL': '1', 01:33:12 INFO - 'TERM': 'linux', 01:33:12 INFO - 'TMOUT': '86400', 01:33:12 INFO - 'USER': 'cltbld', 01:33:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', 01:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:12 INFO - '_': '/tools/buildbot/bin/python'} 01:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:12 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)) 01:33:12 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)) 01:33:12 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)) 01:33:12 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)) 01:33:12 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)) 01:33:12 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)) 01:33:12 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)) 01:33:12 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)) 01:33:12 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)) 01:33:12 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)) 01:33:12 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)) 01:33:12 INFO - Cleaning up... 01:33:12 INFO - Return code: 0 01:33:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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')]} 01:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:12 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 0x7f42bd861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1c0>, '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 0x100b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', '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 01:33:12 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 01:33:12 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 01:33:12 INFO - Using env: {'DISPLAY': ':0', 01:33:12 INFO - 'HOME': '/home/cltbld', 01:33:12 INFO - 'LANG': 'en_US.UTF-8', 01:33:12 INFO - 'LANGUAGE': 'en_US:en', 01:33:12 INFO - 'LOGNAME': 'cltbld', 01:33:12 INFO - 'MAIL': '/var/mail/cltbld', 01:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:12 INFO - 'MOZ_NO_REMOTE': '1', 01:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:12 INFO - 'NO_EM_RESTART': '1', 01:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:12 INFO - 'PWD': '/builds/slave/test', 01:33:12 INFO - 'SHELL': '/bin/bash', 01:33:12 INFO - 'SHLVL': '1', 01:33:12 INFO - 'TERM': 'linux', 01:33:12 INFO - 'TMOUT': '86400', 01:33:12 INFO - 'USER': 'cltbld', 01:33:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', 01:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:12 INFO - '_': '/tools/buildbot/bin/python'} 01:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:33:12 INFO - Cleaning up... 01:33:12 INFO - Return code: 0 01:33:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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')]} 01:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:12 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 0x7f42bd861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a1c0>, '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 0x100b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', '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 01:33:12 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 01:33:12 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 01:33:12 INFO - Using env: {'DISPLAY': ':0', 01:33:12 INFO - 'HOME': '/home/cltbld', 01:33:12 INFO - 'LANG': 'en_US.UTF-8', 01:33:12 INFO - 'LANGUAGE': 'en_US:en', 01:33:12 INFO - 'LOGNAME': 'cltbld', 01:33:12 INFO - 'MAIL': '/var/mail/cltbld', 01:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:12 INFO - 'MOZ_NO_REMOTE': '1', 01:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:12 INFO - 'NO_EM_RESTART': '1', 01:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:12 INFO - 'PWD': '/builds/slave/test', 01:33:12 INFO - 'SHELL': '/bin/bash', 01:33:12 INFO - 'SHLVL': '1', 01:33:12 INFO - 'TERM': 'linux', 01:33:12 INFO - 'TMOUT': '86400', 01:33:12 INFO - 'USER': 'cltbld', 01:33:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', 01:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:12 INFO - '_': '/tools/buildbot/bin/python'} 01:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:12 INFO - Downloading/unpacking flake8 01:33:12 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 01:33:12 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 01:33:12 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 01:33:12 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 01:33:12 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 01:33:12 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 01:33:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:33:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:33:14 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 01:33:14 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 01:33:14 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 01:33:14 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 01:33:14 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 01:33:14 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 01:33:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:33:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:33:15 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 01:33:15 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 01:33:15 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 01:33:15 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 01:33:15 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 01:33:15 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 01:33:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:33:15 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 01:33:15 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 01:33:15 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 01:33:15 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 01:33:15 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 01:33:15 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 01:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:33:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:33:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:33:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:33:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:33:15 INFO - no previously-included directories found matching 'docs/_build' 01:33:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:33:15 INFO - Running setup.py install for pep8 01:33:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:33:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:33:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:33:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:33:15 INFO - no previously-included directories found matching 'docs/_build' 01:33:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:33:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:33:15 INFO - Cleaning up... 01:33:15 INFO - Return code: 0 01:33:15 INFO - Running post-action listener: _resource_record_post_action 01:33:15 INFO - Running post-action listener: _start_resource_monitoring 01:33:15 INFO - Starting resource monitoring. 01:33:15 INFO - ##### 01:33:15 INFO - ##### Finished create-virtualenv step (success) 01:33:15 INFO - ##### 01:33:15 INFO - ##### 01:33:15 INFO - ##### Running install step. 01:33:15 INFO - ##### 01:33:15 INFO - Running pre-action listener: _resource_record_pre_action 01:33:15 INFO - Running main action method: install 01:33:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:33:16 INFO - Reading from file tmpfile_stdout 01:33:16 INFO - Detecting whether we're running mozinstall >=1.0... 01:33:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:33:16 INFO - Reading from file tmpfile_stdout 01:33:16 INFO - Output received: 01:33:16 INFO - Usage: mozinstall [options] installer 01:33:16 INFO - Options: 01:33:16 INFO - -h, --help show this help message and exit 01:33:16 INFO - -d DEST, --destination=DEST 01:33:16 INFO - Directory to install application into. [default: 01:33:16 INFO - "/builds/slave/test"] 01:33:16 INFO - --app=APP Application being installed. [default: firefox] 01:33:16 INFO - mkdir: /builds/slave/test/build/application 01:33:16 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'] 01:33:16 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 01:33:32 INFO - Reading from file tmpfile_stdout 01:33:32 INFO - Output received: 01:33:32 INFO - /builds/slave/test/build/application/firefox/firefox 01:33:32 INFO - Running post-action listener: _resource_record_post_action 01:33:32 INFO - ##### 01:33:32 INFO - ##### Finished install step (success) 01:33:32 INFO - ##### 01:33:32 INFO - ##### 01:33:32 INFO - ##### Running run-tests step. 01:33:32 INFO - ##### 01:33:32 INFO - Running pre-action listener: _resource_record_pre_action 01:33:32 INFO - Running main action method: run_tests 01:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:33:32 INFO - Python 2.7.3 01:33:32 INFO - Return code: 0 01:33:32 INFO - grabbing minidump binary from tooltool 01:33:32 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')]} 01:33:32 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 0x100a1c0>, '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 0x100b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:33:32 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 01:33:32 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 01:33:32 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 01:33:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:33:32 INFO - Return code: 0 01:33:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:33:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:33:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:33:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:33:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:33:33 INFO - Return code: 0 01:33:33 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/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 01:33:33 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/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 01:33:33 INFO - Using env: {'DISPLAY': ':0', 01:33:33 INFO - 'HOME': '/home/cltbld', 01:33:33 INFO - 'LANG': 'en_US.UTF-8', 01:33:33 INFO - 'LANGUAGE': 'en_US:en', 01:33:33 INFO - 'LOGNAME': 'cltbld', 01:33:33 INFO - 'MAIL': '/var/mail/cltbld', 01:33:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:33:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:33 INFO - 'MOZ_NO_REMOTE': '1', 01:33:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:33:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:33 INFO - 'NO_EM_RESTART': '1', 01:33:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:33 INFO - 'PWD': '/builds/slave/test', 01:33:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:33:33 INFO - 'SHELL': '/bin/bash', 01:33:33 INFO - 'SHLVL': '1', 01:33:33 INFO - 'TERM': 'linux', 01:33:33 INFO - 'TMOUT': '86400', 01:33:33 INFO - 'USER': 'cltbld', 01:33:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311', 01:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:33 INFO - '_': '/tools/buildbot/bin/python'} 01:33:33 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/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 01:33:33 INFO - mozversion application_buildid: 20160621003900 01:33:33 INFO - mozversion application_changeset: 21a0421ca9b0e39a28b1ab1875b6ac33f06f23da 01:33:33 INFO - mozversion application_display_name: Nightly 01:33:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:33:33 INFO - mozversion application_name: Firefox 01:33:33 INFO - mozversion application_remotingname: firefox 01:33:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:33:33 INFO - mozversion application_vendor: Mozilla 01:33:33 INFO - mozversion application_version: 50.0a1 01:33:33 INFO - mozversion platform_buildid: 20160621003900 01:33:33 INFO - mozversion platform_changeset: 21a0421ca9b0e39a28b1ab1875b6ac33f06f23da 01:33:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:33:33 INFO - mozversion platform_version: 50.0a1 01:33:33 INFO - using testdate: 1466498013 01:33:33 INFO - actual date: 1466498013 01:33:33 INFO - starting webserver on 'localhost:59329' 01:33:33 INFO - SUITE-START | Running 2 tests 01:33:33 INFO - TEST-START | dromaeo_css 01:33:33 INFO - operating with platform_type : linux_ 01:33:33 INFO - Initialising browser for dromaeo_css test... 01:33:33 INFO - TEST-INFO | started process 17885 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl85ZdX/profile http://localhost:59329/getInfo.html) 01:33:38 INFO - PROCESS | 17885 | __metrics Screen width/height:1600/1200 01:33:38 INFO - PROCESS | 17885 | colorDepth:24 01:33:38 INFO - PROCESS | 17885 | Browser inner width/height: 1024/697 01:33:38 INFO - PROCESS | 17885 | __metrics 01:33:38 ERROR - PROCESS | 17885 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 01:33:39 INFO - TEST-INFO | 17885: exit 0 01:33:39 INFO - Browser initialized. 01:33:39 INFO - Running cycle 1/1 for dromaeo_css test... 01:33:39 INFO - TEST-INFO | started process 18002 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl85ZdX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:33:51 INFO - PROCESS | 18002 | RSS: Main: 185831424 01:33:51 INFO - PROCESS | 18002 | 01:34:41 INFO - PROCESS | 18002 | 1466498081342 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] 01:36:53 INFO - PROCESS | 18002 | Cycle 1(1): loaded http://localhost:59329/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59329/tests/dromaeo/cssquery-ext.html) 01:36:55 INFO - PROCESS | 18002 | RSS: Main: 188166144 01:36:55 INFO - PROCESS | 18002 | 01:39:57 INFO - PROCESS | 18002 | Cycle 1(1): loaded http://localhost:59329/tests/dromaeo/cssquery-ext.html (next: http://localhost:59329/tests/dromaeo/cssquery-jquery.html) 01:39:57 INFO - PROCESS | 18002 | RSS: Main: 187613184 01:39:57 INFO - PROCESS | 18002 | 01:42:59 INFO - PROCESS | 18002 | Cycle 1(1): loaded http://localhost:59329/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59329/tests/dromaeo/cssquery-mootools.html) 01:43:00 INFO - PROCESS | 18002 | RSS: Main: 189030400 01:43:00 INFO - PROCESS | 18002 | 01:46:02 INFO - PROCESS | 18002 | Cycle 1(1): loaded http://localhost:59329/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59329/tests/dromaeo/cssquery-prototype.html) 01:46:02 INFO - PROCESS | 18002 | RSS: Main: 186810368 01:46:02 INFO - PROCESS | 18002 | 01:49:05 INFO - PROCESS | 18002 | Cycle 1(1): loaded http://localhost:59329/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59329/tests/dromaeo/cssquery-yui.html) 01:49:06 INFO - PROCESS | 18002 | RSS: Main: 189272064 01:49:06 INFO - PROCESS | 18002 | 01:52:08 INFO - PROCESS | 18002 | Cycle 1(1): loaded http://localhost:59329/tests/dromaeo/cssquery-yui.html (next: http://localhost:59329/tests/dromaeo/cssquery-dojo.html) 01:52:08 INFO - PROCESS | 18002 | RSS: Main: 189943808 01:52:08 INFO - PROCESS | 18002 | 01:52:08 INFO - PROCESS | 18002 | __start_tp_report 01:52:08 INFO - PROCESS | 18002 | _x_x_mozilla_page_load 01:52:08 INFO - PROCESS | 18002 | _x_x_mozilla_page_load_details 01:52:08 INFO - PROCESS | 18002 | |i|pagename|runs| 01:52:08 INFO - PROCESS | 18002 | |0;dojo.html;2622.8032897532685;2689.67723873135;2690.569508878579;2722.020072773801;2722.9455410891783;4766.404199475061;4824.589909857662;4845.127876982142;4874.6831455955335;4896.412430508344;4761.381020467343;4816.229403295473;4821.8794530136765;4890.021995600885;4971.204607262839;4338.479382474107;4363.280058790296;4372.825086996516;4493.415855938723;4528.660350473711;4426.490953540336;4497.370368148462;4505.662075344346;4513.593776560109;4536.455625324949;4343.869683909487;4394.780260986938;4408.448943882015;4459.710118842281;4461.821527138911;4401.889952751175;4409.867703968886;4413.6910416270875;4416.911661766747;4445.799939002753;4435.933460998088;4443.955670417449;4444.222261104326;4448.399466072071;4491.146682130385;4831.323614693945;4879.4388645305535;4902.950970490321;4914.164592019365;4938;5292.311999440049;5293.285406470154;5305.442928492491;5313.1764576490705;5319.015982043335;5356.11624082026;5363.919541206885;5372.677639341613;5373.704446255454;5375.623706340558;4842.12841688496;4899.804007839718;4941.061198372297;4946.752662366867;4967.907060446696;5439.809606663748;5444.074507333763;5475.315585551806;5479.123340265618;5488.945110548843;5094.981003799255;5228.843134705965;5229.137192363218;5232.712200828991;5265.76304066318;5085.974570127126;5208.348956380452;5244.108501554745;5255.921161182585;5262.578993680497;5238.476152384731;5263.131583288791;5313.654612450256;5313.973430132824;5315.946840531546;5017.397912250553;5254.605904557174;5258.947410525846;5259.684418934876;5298.655587386807;4417.646588272931;4426.114777044604;4447.132809102259;4448.621867141264;4455.933161002587;3839.2897313997;3855.9807200963814;3869.6323849234277;3898.766074035567;3904.707146963989;4447.822087116479;4464.799084041161;4475.664325175625;4537.410136682211;4574.5425457453985;5236.423993360727;5253.369595648546;5254.710990895461;5272.841814745564;5318.202269659582;4453.599176074169;4499.21263778844;4509.7970591323465;4510.954890451119;4545.477270113913;4651.325557794168;4711.882202944954;4716.858494245178;4757.8096876125255;4759.16714574948;4932.53140951609;4973.45292017885;4973.651844370859;5003.44962054181;5025.974870125699;5320.201969704421;5324.307839980933;5325.840224793263;5342.786288548415;5378.1663842104535;4868.732219727807;4910.533499317559;4937.876553086058;4969.229769385751;4995.225740010304;5190.065788158167;5212.113940630026;5216.191490319006;5217.321748172713;5220.738963051908;5290.7883684653725;5295.232191332312;5295.735213239245;5298.28473156119;5342.198670199501;4954.702717836942;5027.2207807789855;5093.0577843099145;5093.541581257705;5106.897862042664;5023.045621331935;5025.120603894377;5028.723420211777;5076;5088.465711100281;4987.301777751045;5006.048850718352;5027.974860125676;5033.245013247895;5070.163423035306;5078.4667609900425;5156.04613146569;5159.561437277874;5183.766730497212;5205.947940520698;5027.296178535081;5051.520105589963;5075.1625981712605;5095.796168153232;5155.123628983157 01:52:08 INFO - PROCESS | 18002 | |1;ext.html;541.5249419450574;583.1078449971544;588.179489611991;599.0564860344956;602.2231321595142;35010;38517.61482385182;38523.22953540928;38578.421323680166;38752.22495550091;38786.8060659697;39305;39336.80331598345;39364.409533856946;39364.40953385702;7740.612969351538;7848.2151784821635;7869.960650196741;7876.921230787676;7881.369490440751;7821.5307081575;7871.9212807872045;7879.212078792132;7880.054393472791;7894.131645518988;7877.409194310421;7882.054153501559;7900.091489478697;7908;7910.920890791076;7808.726694565663;7840.921590784076;7848.607569621525;7858.17489163641;7865.174156713577;7821.921780782176;7872.763817085496;7888.211178882066;7897.328727058207;7917;37234.81382593097;37657.81171094155;37691.62308376909;37743.43384849229;37763.433548496796;2525.494901019785;2897.985510072457;2975.747061499775;2998.580198772174;3029.106413607991;27374.863125684442;27793.02724404636;27995.300117497023;28183.859080704464;28861.56707649387;3173.1591128351006;3203.2952750394875;3225.5645487859074;3266.803991760502;3274.8690052397874;201993;255384;256609;256851;256859;54449.45550544523;55244.17133742997;55334.72332638311;55355;55432.72283638556;32917.67082329194;33657.66342336594;33693.663063369546;35594;35600;13293.335333233299;13573.049886508046;13574.185548867099;13615.25116118623;13686.878533827272;10009.749756256151;10138.03688649577;10180.134688551556;10237.078662920225;10245.795084098425;17940.730889036677;18170.81829181691;18310.450686479428;18322.63354732898;18346.724799128024;6974.884018557006;6985;7021.719131234796;7103.964480177669;7114.608696521741;782.0927723840318;882.8278485695228;954.1841725324886;986.2405947420447;1005.7083445800782;27587.448251034868;27981.86009069982;28222.29444263869;28478.71521284802;28705.56941645877;994.3387647214666;996.1731762636994;1019.9439030853226;1034.4310629153936;1064.302881612545;14372.209528475825;14946.40214391434;15030;15163.772543411858;15170.469033583771;401469;405179;405979;406205;406341;48158.518414816106;49455.75272123688;49511.752441238285;49783;49984.25023624649;1193.797054500737;1202.7955247607927;1202.8857258560422;1210.1589395370308;1216.6775804411839;26910.770707515225;27283.181504554894;27518;27558.72441275642;28016.719832801413;37277.440838387985;37448.812755937135;37602.811985939894;37735.62264377431;37890;259301;261045;261534;261781;262637;25282.873585631954;25383.857726402726;26302.605460918483;26382;27364.315892102855;41143.55997540072;41332.79333603313;42362.36456453094;42382;42654;35635.64364356427;35769;36210.63789362178;36352.09119771921;36639;35053;35092.473612896334;35313.47029794504;35386.1153471155;35589;35424.46863297104;35666.821665892545;35997.1000724984;37134.8143259282;37152.81423592865;30263.394732104793;31936.840315798272;32428.67571324351;32451.837740811145;32541;25052.74947250577;25208.722617580526;25368.365790855376;25441.872790635927;26071.478570428866 01:52:08 INFO - PROCESS | 18002 | |2;jquery.html;368.8284947499412;371.44469018816875;371.7639299045106;382.78084301499706;386.56897559221477;15582.142982135992;17219.827801721978;17413.216405261763;17769.46691599254;17808.821911780877;16180.919095404535;16362;17095.230714617843;17182.656346873056;17236.569085772862;5056.165732654108;5258.237555554442;5289;5294.947050529503;5306.442823503515;3666.615005424432;5185.844424667266;5857.150713146591;6165.260168779752;6173.259208894939;6201.1008403781425;6205.162303089093;6206.906896396557;6228.408301211378;6258.968705156468;5066.088104141253;5386.084365657828;5387.568994480433;5434.510894019518;5445.37378201504;5172.741362931876;5236.371635403738;5239.816606418757;5257.158854583248;5305.336832895888;12117.818232726517;12463.376831158406;12484.438200280918;19911.303104391423;20023.934968392994;1890;1892.7350170976074;1929.199382256362;1940.922363105474;2039.694045893113;8983.775405614846;9071.546422678839;9254.722358329262;9275.721728348093;9879.308448408614;1787.5977904971407;1887.9150438230313;2030.5837303352926;2096.423483542023;2120.766715661276;78996.07529435316;79897.20102798956;80811.5959420205;81010.18989810086;81891.5905420469;15956.122413267381;16562;16623.91688041552;16679.833201668072;16780;29177;29244;29362.853185733933;29413.11760647184;29831.40337193244;7822.687092516349;8164.142765009708;8253;8357.788120722462;8393.24460798531;6462.773802916875;6515.478761699147;6518.44593209573;6782.084418603524;6794.9660251699415;8291.95854020726;8413.242808147173;8437.746867593982;8531.616077276538;8587.613557389932;1506.6534697019747;1586.2465328968647;1594.3144447887287;1614.862736667373;3100.6279246490567;817.9591020448954;863.2403484933219;867.098217853438;897.9955100224457;933.1415098109755;16083.919580402024;16314.510564683078;16408.917955410147;16563.171841408122;16690.58273543171;797.8005498625344;843.5444859775653;846.331398195431;863.4948555095214;895.7312806158127;8681.91318086811;9059.728208153765;9355;9376.437413755197;9522.761930951781;301943;385672;388605;393552;430006;72398.63800681068;81447.59276203581;85341.57329213314;87067;87632.56183719041;423.7288135593223;437.46847580190223;437.9167958087953;438.9275769497997;439.2620397731777;9455.669051583161;10211.591536338761;10216.387016779017;10247.641332553325;10442.373457592568;36104.27791444209;36859;37569.4364584526;37893;38317.616823831406;51010.74494627503;52632;52710.209346860596;52805;52849.47150528599;7274.599897005715;7791.571463569331;7796.688132474637;7846.254605812439;7883.802904927423;9005.63977440895;11801.35092569917;11823.11326650522;11950.087985922211;12047.277163370225;9903.405795652285;9945.353552019096;10188.745281368025;10254.6410875619;10589.205809564159;10090.848637270594;10308.350663893742;10529;10572.20708446885;10579;10274.308774608679;10443.791124177626;10497;10646.520906559379;10844.132469402586;7574.204708505748;7591.430642701709;7686.538807671557;7733.845323093619;7794.92205077942;10253.231007674305;10332.431716255678;10429.217808664229;10463.947680261854;10483.633072842415 01:52:08 INFO - PROCESS | 18002 | |3;mootools.html;1247.1270110922353;1331.9001074919383;1359.3814814259513;1657.8839481236319;1701.863850891928;6530.738770449188;7321.816954576125;7360.705571777129;7901.091374491928;7906.723264685737;7410.147832999207;7651.043619547557;7697.114831794332;7703.807404814883;7707.30634242918;2132.4775430019627;2192.9232476863313;2193.254293540196;2195.056125865877;2199.1643175593254;2168.5988092202915;2176.2056849250066;2212.2478357358495;2215.601191785478;2222.899969501368;2143.839212059094;2163.9134434622597;2170.066871245364;2174.8260139188906;2194.7695491973354;2048.4366799130207;2055.7973585452455;2056.7634722006937;2058.752949646037;2060.7527096748336;2130.669746189343;2163.6754486826944;2168.1002384010617;2170.2295685031904;2170.305502239284;7581.3934885209055;7706.884396734054;7790.104138024143;7797.259260370256;7802.180771019075;4378.452693413324;4483.798229079699;4506.459224893034;4519.774011299455;4529.0715403342565;2731.399092199713;2836.078274560776;2841.1476557033016;2905.7094290570985;2909.1999700082433;833.9082700902895;845.5729856422467;883.8895138107737;884.1909652667802;887.2148148888216;10268.486575671186;10324.690259292232;10335.586576536929;10338;10341.63804266847;3958.7822669752863;4003.3394489908837;4057.634812866797;4143.7306575072525;4143.751374917515;8922.197002269826;8937.06160853101;8944.776380590407;8952.776180595538;8971.282297416192;4464.888377790517;4530.22986092365;4537.160625284333;4544.113897789965;4547.15877562652;3497.4753786931656;4007.1184339445276;4115.34154535273;4170.77060761655;4240.151969606091;3562.679358857715;3571.9285614288087;3649.379605467077;3678.2275722098657;3716.089558058293;1122.4912320962642;1148.121686909515;1177.8881006304387;1181.173178774861;1188.2276520261898;680.4556354916048;736.3961551527696;812.5246730662628;827.4042689263721;843.0894633795486;5023.472535383805;5053.949460505348;5154.201098829687;5165.431802501722;5281.762320695501;827.2720006394335;836.7782537627534;865.0095640491602;884.2793123604242;898.7483504618717;3203.51947207916;3256.316173603522;3268.4280250956463;3289.013296011187;3289.210589458513;8634.5251011195;9062.637494500146;9357.438553686801;9368.156865882103;9393.201577865959;8981.595828187747;9124.905011398541;9174.816503669888;9221.49281789508;9232.215261702697;7039.54242974205;7086.078809754802;7146.428285737128;7200.891986620205;7329.853402932018;5063.87340316495;5204.245384419314;5329.147336426308;5368.1679339702405;5470.425605311385;8380.53907035119;8598.355123365647;8615.741527754177;8696.521691307038;8714.825703485769;8577.8713319299;8908.287337013153;8930.687425940061;9016.729498115066;9076.137766912132;5753.482186603226;6446.613203207822;6507.511936604679;6654.035164900965;6680.365365290289;7438.814029649302;7493.213212612597;7502.3622992046285;7509.6245187739305;7593.658285377061;6459.160309159779;6634.170728658918;6667.733290668319;6705.664716764045;6714.630695311805;6378.649174295459;6402.839929001812;6494.155759751202;6590.47276217911;6645.1361323027695;6298.748050077946;6304.3380445054445;6333.809985700436;6349.8730025400155;6358.109864619049;4490.191765482245;4494.1461122386645;4585.495595484561;4637.884052898705;4656.208444564364;4265.9360109599;4329.6969212154845;4420.77896105187;4484.439445069366;4516.299973504112 01:52:08 INFO - PROCESS | 18002 | |4;prototype.html;290.18458132647265;293.14109658700016;297.64431504352297;299.5985379591347;303.9118655589879;5087.2114822202575;5141.22881567765;5142.6914385136915;5160.277561141444;5168.121419358708;5003.449620541746;5007.672966663837;5011.4737952514915;5028.773705183266;5055.696658200511;3936.960630393688;3948.763074215542;3968.6386599973116;3969.3450580654157;3975.6819454443576;3638.472421498881;3887.8056097195026;3987.940180897289;3998.9600103999023;4004.8786339824896;3788.2423515296914;3816.026913137146;3817.618238176188;3824.388097904336;3831.942520862189;3809.5428548574073;3824.4072168813877;3828.406596977473;3828.578856325802;3828.674562662163;3204.6955539223736;3278.442664746975;3320.8671653133847;3373.510840928076;3377.240120972786;4987.077390682735;4989.501049895018;5035.269885866565;5041.571466425358;5048.318477005594;4436.534163912775;4462.754548499831;4469.41897553316;4505.3917721107555;4508.827704796744;5108.667936584147;5376.731163441851;5379.220013098079;5402.594805389612;5409.350877894639;3673.210259794157;3684.042149041242;3695.5380577427823;3700.7039436845257;3725.2921944830396;5542.584306177053;5627.943720562824;5632.324121105453;5635.436456354331;5660.490555849993;3560.1989552351033;3762.6237376262156;3787.223619158066;3792.8482860685262;3793.5637401698605;3868.864589739346;3874.12832112778;3875.5736868944396;3890.0858298299877;3891.5135608048995;4378.190034843564;4447.66497588762;4459.241928872099;4466.397036400044;4491.550844915548;5217.478252174828;5358.732063396893;5417.566594672417;5432.837014889559;5498.615096943256;1325.4698120751777;1352.0265408905573;1352.7362164377853;1352.8850047746052;1354.5056054540023;819.4264015189273;831.1854382704862;845.3068483843313;849.7918010087568;856.4818284937647;4271.829126834954;4291.54938731435;4320.935185972213;4321.956780432219;4346.587074227943;4863.10032643962;5023.522765337287;5038.571721403649;5047.747612619354;5061.44324124346;4209.24233637942;4234.957650423518;4315.244832154361;4315.287977483743;4316.072044510445;2492.2772396004957;2590.663213782196;2598.402367455496;2812.774978001755;2889.7832662550395;5177.378714554277;5201.531862132426;5210.609204309616;5228.241904923765;5235.842924712265;5638.026690658319;5640.323161220597;5658.519025882846;5674.971625141848;5693.345265294462;4967.950320496749;5156.4070131935305;5203.401608815035;5212.270282160424;5224.686518808883;5531.8893622128135;5551.306086739158;5554.638948468337;5558.471945165203;5562.860928476821;5336.599755018312;5375.784968601369;5389.83830485086;5404.432714512747;5443.891122177455;4943.530364615356;5252.896891652796;5254.927431240666;5264.184051472028;5277.894442111059;3797.525309336333;3865.7487263327794;3873.8450461981206;3895.610438956195;3918.451416801593;5456.345238571397;5632.633878797865;5633.295838020247;5649.519790817826;5698;5398.892022159614;5426.267453893832;5432.483914028161;5447.727613619224;5457.372402173801;5354.36691809002;5425.233131103087;5440.6735595864375;5443.482869127427;5452.945470545244;5085.949140508547;5180.404253510744;5218.060749065205;5259.789608415621;5311.326033090855;5465.699386533779;5469.562435005269;5474.972625136849;5515.200295957144;5521.806736764194;5363.659085228693;5408.269883565826;5410.75651595687;5444.754986025559;5447.291852059207 01:52:08 INFO - PROCESS | 18002 | |5;yui.html;625.2247213455315;628.0735914526075;632.9208848893888;657.132584987816;718.052171134103;11748.647540573775;12205.450754716037;13017.934910325446;13317.467301307948;14093.295335233248;13949.30253487324;14082.71834563308;14172.433102675906;14177.149371037745;14187.432502699905;797.9441439099265;805.9395545334094;806.2501873257868;806.2662976691212;808.0101875202859;790.3361176611645;791.0507391130637;791.9326857217144;794.5153456391597;795.6021989005498;838.8741688746676;842.4481964313385;843.4981186194235;844.3920377328313;846.7713717296357;790.8141586727114;822.9629666665014;826.3389288569151;830.7466222802043;834.5451728807815;591.7130191856946;594.1711312718733;596.3470000349654;598.7036416973582;599.0505049496553;13930.024898257127;13970.860291397057;13982.230977296347;14025.78961315581;14038.298085095705;12849.164804287784;13303.04253167337;13468.945293961948;13515.932420337933;13658.726825463535;10882.29265097766;10944.124470042378;11001.394923279217;11032.22774405792;11130.08328396692;3336.182635254378;3348.598168219805;3350.832458377096;3368.5620869286836;3419.4870769384543;67313.3268667312;67463;67465.66267168682;68238.65880670614;68368.31631683718;10553.47232638365;10713.892861071445;10718.571257149626;10719.678409647722;10799.730006749736;19095.42713718563;19183.80816191848;19232.134553945107;19304.1313140909;19568.902155489417;6569.58283149017;6672.699728512229;6686.1642294713165;6691.5650482718465;6800.455963523005;3722.1253005543676;3737.5141231639714;3738.4392341149046;3744.6068162843053;3789.5831458539537;2969.287371030937;3077.8461076946064;3085.5371694245596;3087.012156110023;3090.0884239149505;502.2366003674467;507.401266505527;511.2484647568069;512.4337606944347;515.5411683601598;567.8410045187354;595.238095238096;598.3627436779902;603.6559161278029;615.8429600451856;8065.792026746663;8135.267825895698;8316.293115085164;8395.286400656012;8768.912310876936;464.6538328944958;572.5276646766351;594.6342999055549;611.9418655227746;623.8190924631897;3574.267275208576;3860.285847118292;3941.2905676977844;3975.4831871856472;4022.336314508132;106193.46903265589;107064;107401.4629926861;108370;109000;91980.54009729909;92203.53898230466;92584.07415925755;92651;92653;48278.75860620745;51216;77391;86984.56507717421;88762;7420.703171873281;7474.7757567273065;7622.847543049219;7767.805804854924;7770.805729856799;46891.296630549885;47802.28296575624;47822.76088619535;47945.28082078702;48817;62789.37210627835;67089;67357.3264267351;67404.3259567398;67558;9396.624135034523;9916.851247231441;9951.850722239027;10009.749756256151;10012.998700129929;11286.774264514828;11492.36791976416;11545.249558778652;11879.940600296943;11918.106142039209;9440.669576564787;9476.241900648069;9803.754906127118;10327;10640.627578034731;9277.907220927704;9781.706548803548;9787.951060244937;9857.704268871945;10262.58949642006;10154.746131346776;10356.585736570754;10375.429351385746;10385.169186465217;10425.582976680847;9176.6788162414;9227.984921658477;9749.853752193865;9759.9024009759;9795.853062204214;8811.559422029;9175.174234318943;9242.815143696955;9246.398984066014;9358.4384936904 01:52:08 INFO - PROCESS | 18002 | __end_tp_report 01:52:08 INFO - PROCESS | 18002 | __start_cc_report 01:52:08 INFO - PROCESS | 18002 | _x_x_mozilla_cycle_collect,391 01:52:08 INFO - PROCESS | 18002 | __end_cc_report 01:52:08 INFO - PROCESS | 18002 | __startTimestamp1466499128789__endTimestamp 01:52:08 INFO - PROCESS | 18002 | 01:52:08 INFO - PROCESS | 18002 | ------- Summary: start ------- 01:52:08 INFO - PROCESS | 18002 | Number of tests: 6 01:52:08 INFO - PROCESS | 18002 | 01:52:08 INFO - PROCESS | 18002 | [#0] dojo.html Cycles:165 Average:4845.56 Median:4973.65 stddev:536.40 (10.8%) stddev-sans-first:508.92 01:52:08 INFO - PROCESS | 18002 | Values: 2622.8 2689.7 2690.6 2722.0 2722.9 4766.4 4824.6 4845.1 4874.7 4896.4 4761.4 4816.2 4821.9 4890.0 4971.2 4338.5 4363.3 4372.8 4493.4 4528.7 4426.5 4497.4 4505.7 4513.6 4536.5 4343.9 4394.8 4408.4 4459.7 4461.8 4401.9 4409.9 4413.7 4416.9 4445.8 4435.9 4444.0 4444.2 4448.4 4491.1 4831.3 4879.4 4903.0 4914.2 4938.0 5292.3 5293.3 5305.4 5313.2 5319.0 5356.1 5363.9 5372.7 5373.7 5375.6 4842.1 4899.8 4941.1 4946.8 4967.9 5439.8 5444.1 5475.3 5479.1 5488.9 5095.0 5228.8 5229.1 5232.7 5265.8 5086.0 5208.3 5244.1 5255.9 5262.6 5238.5 5263.1 5313.7 5314.0 5315.9 5017.4 5254.6 5258.9 5259.7 5298.7 4417.6 4426.1 4447.1 4448.6 4455.9 3839.3 3856.0 3869.6 3898.8 3904.7 4447.8 4464.8 4475.7 4537.4 4574.5 5236.4 5253.4 5254.7 5272.8 5318.2 4453.6 4499.2 4509.8 4511.0 4545.5 4651.3 4711.9 4716.9 4757.8 4759.2 4932.5 4973.5 4973.7 5003.4 5026.0 5320.2 5324.3 5325.8 5342.8 5378.2 4868.7 4910.5 4937.9 4969.2 4995.2 5190.1 5212.1 5216.2 5217.3 5220.7 5290.8 5295.2 5295.7 5298.3 5342.2 4954.7 5027.2 5093.1 5093.5 5106.9 5023.0 5025.1 5028.7 5076.0 5088.5 4987.3 5006.0 5028.0 5033.2 5070.2 5078.5 5156.0 5159.6 5183.8 5205.9 5027.3 5051.5 5075.2 5095.8 5155.1 01:52:08 INFO - PROCESS | 18002 | 01:52:08 INFO - PROCESS | 18002 | [#1] ext.html Cycles:180 Average:45358.82 Median:35617.82 stddev:82389.68 (231.3%) stddev-sans-first:82552.09 01:52:08 INFO - PROCESS | 18002 | Values: 541.5 583.1 588.2 599.1 602.2 35010.0 38517.6 38523.2 38578.4 38752.2 38786.8 39305.0 39336.8 39364.4 39364.4 7740.6 7848.2 7870.0 7876.9 7881.4 7821.5 7871.9 7879.2 7880.1 7894.1 7877.4 7882.1 7900.1 7908.0 7910.9 7808.7 7840.9 7848.6 7858.2 7865.2 7821.9 7872.8 7888.2 7897.3 7917.0 37234.8 37657.8 37691.6 37743.4 37763.4 2525.5 2898.0 2975.7 2998.6 3029.1 27374.9 27793.0 27995.3 28183.9 28861.6 3173.2 3203.3 3225.6 3266.8 3274.9 201993.0 255384.0 256609.0 256851.0 256859.0 54449.5 55244.2 55334.7 55355.0 55432.7 32917.7 33657.7 33693.7 35594.0 35600.0 13293.3 13573.0 13574.2 13615.3 13686.9 10009.7 10138.0 10180.1 10237.1 10245.8 17940.7 18170.8 18310.5 18322.6 18346.7 6974.9 6985.0 7021.7 7104.0 7114.6 782.1 882.8 954.2 986.2 1005.7 27587.4 27981.9 28222.3 28478.7 28705.6 994.3 996.2 1019.9 1034.4 1064.3 14372.2 14946.4 15030.0 15163.8 15170.5 401469.0 405179.0 405979.0 406205.0 406341.0 48158.5 49455.8 49511.8 49783.0 49984.3 1193.8 1202.8 1202.9 1210.2 1216.7 26910.8 27283.2 27518.0 27558.7 28016.7 37277.4 37448.8 37602.8 37735.6 37890.0 259301.0 261045.0 261534.0 261781.0 262637.0 25282.9 25383.9 26302.6 26382.0 27364.3 41143.6 41332.8 42362.4 42382.0 42654.0 35635.6 35769.0 36210.6 36352.1 36639.0 35053.0 35092.5 35313.5 35386.1 35589.0 35424.5 35666.8 35997.1 37134.8 37152.8 30263.4 31936.8 32428.7 32451.8 32541.0 25052.7 25208.7 25368.4 25441.9 26071.5 01:52:08 INFO - PROCESS | 18002 | 01:52:08 INFO - PROCESS | 18002 | [#2] jquery.html Cycles:180 Average:25017.48 Median:439.09 stddev:63567.00 (14476.8%) stddev-sans-first:63718.38 01:52:08 INFO - PROCESS | 18002 | Values: 368.8 371.4 371.8 382.8 386.6 15582.1 17219.8 17413.2 17769.5 17808.8 16180.9 16362.0 17095.2 17182.7 17236.6 5056.2 5258.2 5289.0 5294.9 5306.4 3666.6 5185.8 5857.2 6165.3 6173.3 6201.1 6205.2 6206.9 6228.4 6259.0 5066.1 5386.1 5387.6 5434.5 5445.4 5172.7 5236.4 5239.8 5257.2 5305.3 12117.8 12463.4 12484.4 19911.3 20023.9 1890.0 1892.7 1929.2 1940.9 2039.7 8983.8 9071.5 9254.7 9275.7 9879.3 1787.6 1887.9 2030.6 2096.4 2120.8 78996.1 79897.2 80811.6 81010.2 81891.6 15956.1 16562.0 16623.9 16679.8 16780.0 29177.0 29244.0 29362.9 29413.1 29831.4 7822.7 8164.1 8253.0 8357.8 8393.2 6462.8 6515.5 6518.4 6782.1 6795.0 8292.0 8413.2 8437.7 8531.6 8587.6 1506.7 1586.2 1594.3 1614.9 3100.6 818.0 863.2 867.1 898.0 933.1 16083.9 16314.5 16408.9 16563.2 16690.6 797.8 843.5 846.3 863.5 895.7 8681.9 9059.7 9355.0 9376.4 9522.8 301943.0 385672.0 388605.0 393552.0 430006.0 72398.6 81447.6 85341.6 87067.0 87632.6 423.7 437.5 437.9 438.9 439.3 9455.7 10211.6 10216.4 10247.6 10442.4 36104.3 36859.0 37569.4 37893.0 38317.6 51010.7 52632.0 52710.2 52805.0 52849.5 7274.6 7791.6 7796.7 7846.3 7883.8 9005.6 11801.4 11823.1 11950.1 12047.3 9903.4 9945.4 10188.7 10254.6 10589.2 10090.8 10308.4 10529.0 10572.2 10579.0 10274.3 10443.8 10497.0 10646.5 10844.1 7574.2 7591.4 7686.5 7733.8 7794.9 10253.2 10332.4 10429.2 10463.9 10483.6 01:52:08 INFO - PROCESS | 18002 | 01:52:08 INFO - PROCESS | 18002 | [#3] mootools.html Cycles:180 Average:5014.32 Median:5243.00 stddev:2794.11 (53.3%) stddev-sans-first:2787.60 01:52:08 INFO - PROCESS | 18002 | Values: 1247.1 1331.9 1359.4 1657.9 1701.9 6530.7 7321.8 7360.7 7901.1 7906.7 7410.1 7651.0 7697.1 7703.8 7707.3 2132.5 2192.9 2193.3 2195.1 2199.2 2168.6 2176.2 2212.2 2215.6 2222.9 2143.8 2163.9 2170.1 2174.8 2194.8 2048.4 2055.8 2056.8 2058.8 2060.8 2130.7 2163.7 2168.1 2170.2 2170.3 7581.4 7706.9 7790.1 7797.3 7802.2 4378.5 4483.8 4506.5 4519.8 4529.1 2731.4 2836.1 2841.1 2905.7 2909.2 833.9 845.6 883.9 884.2 887.2 10268.5 10324.7 10335.6 10338.0 10341.6 3958.8 4003.3 4057.6 4143.7 4143.8 8922.2 8937.1 8944.8 8952.8 8971.3 4464.9 4530.2 4537.2 4544.1 4547.2 3497.5 4007.1 4115.3 4170.8 4240.2 3562.7 3571.9 3649.4 3678.2 3716.1 1122.5 1148.1 1177.9 1181.2 1188.2 680.5 736.4 812.5 827.4 843.1 5023.5 5053.9 5154.2 5165.4 5281.8 827.3 836.8 865.0 884.3 898.7 3203.5 3256.3 3268.4 3289.0 3289.2 8634.5 9062.6 9357.4 9368.2 9393.2 8981.6 9124.9 9174.8 9221.5 9232.2 7039.5 7086.1 7146.4 7200.9 7329.9 5063.9 5204.2 5329.1 5368.2 5470.4 8380.5 8598.4 8615.7 8696.5 8714.8 8577.9 8908.3 8930.7 9016.7 9076.1 5753.5 6446.6 6507.5 6654.0 6680.4 7438.8 7493.2 7502.4 7509.6 7593.7 6459.2 6634.2 6667.7 6705.7 6714.6 6378.6 6402.8 6494.2 6590.5 6645.1 6298.7 6304.3 6333.8 6349.9 6358.1 4490.2 4494.1 4585.5 4637.9 4656.2 4265.9 4329.7 4420.8 4484.4 4516.3 01:52:08 INFO - PROCESS | 18002 | 01:52:08 INFO - PROCESS | 18002 | [#4] prototype.html Cycles:180 Average:4387.62 Median:5036.92 stddev:1326.34 (26.3%) stddev-sans-first:1293.92 01:52:08 INFO - PROCESS | 18002 | Values: 290.2 293.1 297.6 299.6 303.9 5087.2 5141.2 5142.7 5160.3 5168.1 5003.4 5007.7 5011.5 5028.8 5055.7 3937.0 3948.8 3968.6 3969.3 3975.7 3638.5 3887.8 3987.9 3999.0 4004.9 3788.2 3816.0 3817.6 3824.4 3831.9 3809.5 3824.4 3828.4 3828.6 3828.7 3204.7 3278.4 3320.9 3373.5 3377.2 4987.1 4989.5 5035.3 5041.6 5048.3 4436.5 4462.8 4469.4 4505.4 4508.8 5108.7 5376.7 5379.2 5402.6 5409.4 3673.2 3684.0 3695.5 3700.7 3725.3 5542.6 5627.9 5632.3 5635.4 5660.5 3560.2 3762.6 3787.2 3792.8 3793.6 3868.9 3874.1 3875.6 3890.1 3891.5 4378.2 4447.7 4459.2 4466.4 4491.6 5217.5 5358.7 5417.6 5432.8 5498.6 1325.5 1352.0 1352.7 1352.9 1354.5 819.4 831.2 845.3 849.8 856.5 4271.8 4291.5 4320.9 4322.0 4346.6 4863.1 5023.5 5038.6 5047.7 5061.4 4209.2 4235.0 4315.2 4315.3 4316.1 2492.3 2590.7 2598.4 2812.8 2889.8 5177.4 5201.5 5210.6 5228.2 5235.8 5638.0 5640.3 5658.5 5675.0 5693.3 4968.0 5156.4 5203.4 5212.3 5224.7 5531.9 5551.3 5554.6 5558.5 5562.9 5336.6 5375.8 5389.8 5404.4 5443.9 4943.5 5252.9 5254.9 5264.2 5277.9 3797.5 3865.7 3873.8 3895.6 3918.5 5456.3 5632.6 5633.3 5649.5 5698.0 5398.9 5426.3 5432.5 5447.7 5457.4 5354.4 5425.2 5440.7 5443.5 5452.9 5085.9 5180.4 5218.1 5259.8 5311.3 5465.7 5469.6 5475.0 5515.2 5521.8 5363.7 5408.3 5410.8 5444.8 5447.3 01:52:08 INFO - PROCESS | 18002 | 01:52:08 INFO - PROCESS | 18002 | [#5] yui.html Cycles:180 Average:18362.72 Median:592.94 stddev:27382.72 (4618.1%) stddev-sans-first:27427.14 01:52:08 INFO - PROCESS | 18002 | Values: 625.2 628.1 632.9 657.1 718.1 11748.6 12205.5 13017.9 13317.5 14093.3 13949.3 14082.7 14172.4 14177.1 14187.4 797.9 805.9 806.3 806.3 808.0 790.3 791.1 791.9 794.5 795.6 838.9 842.4 843.5 844.4 846.8 790.8 823.0 826.3 830.7 834.5 591.7 594.2 596.3 598.7 599.1 13930.0 13970.9 13982.2 14025.8 14038.3 12849.2 13303.0 13468.9 13515.9 13658.7 10882.3 10944.1 11001.4 11032.2 11130.1 3336.2 3348.6 3350.8 3368.6 3419.5 67313.3 67463.0 67465.7 68238.7 68368.3 10553.5 10713.9 10718.6 10719.7 10799.7 19095.4 19183.8 19232.1 19304.1 19568.9 6569.6 6672.7 6686.2 6691.6 6800.5 3722.1 3737.5 3738.4 3744.6 3789.6 2969.3 3077.8 3085.5 3087.0 3090.1 502.2 507.4 511.2 512.4 515.5 567.8 595.2 598.4 603.7 615.8 8065.8 8135.3 8316.3 8395.3 8768.9 464.7 572.5 594.6 611.9 623.8 3574.3 3860.3 3941.3 3975.5 4022.3 106193.5 107064.0 107401.5 108370.0 109000.0 91980.5 92203.5 92584.1 92651.0 92653.0 48278.8 51216.0 77391.0 86984.6 88762.0 7420.7 7474.8 7622.8 7767.8 7770.8 46891.3 47802.3 47822.8 47945.3 48817.0 62789.4 67089.0 67357.3 67404.3 67558.0 9396.6 9916.9 9951.9 10009.7 10013.0 11286.8 11492.4 11545.2 11879.9 11918.1 9440.7 9476.2 9803.8 10327.0 10640.6 9277.9 9781.7 9788.0 9857.7 10262.6 10154.7 10356.6 10375.4 10385.2 10425.6 9176.7 9228.0 9749.9 9759.9 9795.9 8811.6 9175.2 9242.8 9246.4 9358.4 01:52:08 INFO - PROCESS | 18002 | -------- Summary: end -------- 01:52:08 INFO - PROCESS | 18002 | 01:52:09 INFO - TEST-INFO | 18002: exit 0 01:52:09 INFO - TEST-OK | dromaeo_css | took 1116100ms 01:52:09 INFO - TEST-START | kraken 01:52:09 INFO - operating with platform_type : linux_ 01:52:09 INFO - Initialising browser for kraken test... 01:52:09 INFO - TEST-INFO | started process 18239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0rOz1f/profile http://localhost:59329/getInfo.html) 01:52:14 INFO - PROCESS | 18239 | __metrics Screen width/height:1600/1200 01:52:14 INFO - PROCESS | 18239 | colorDepth:24 01:52:14 INFO - PROCESS | 18239 | Browser inner width/height: 1024/697 01:52:14 INFO - PROCESS | 18239 | __metrics 01:52:14 ERROR - PROCESS | 18239 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 01:52:15 INFO - TEST-INFO | 18239: exit 0 01:52:15 INFO - Browser initialized. 01:52:15 INFO - Running cycle 1/1 for kraken test... 01:52:15 INFO - TEST-INFO | started process 18356 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0rOz1f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:52:27 INFO - PROCESS | 18356 | RSS: Main: 185884672 01:52:27 INFO - PROCESS | 18356 | 01:52:30 INFO - PROCESS | 18356 | Cycle 1(1): loaded http://localhost:59329/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59329/tests/kraken/driver.html?testName=audio-beat-detection) 01:52:31 INFO - PROCESS | 18356 | RSS: Main: 190943232 01:52:31 INFO - PROCESS | 18356 | 01:52:34 INFO - PROCESS | 18356 | Cycle 1(1): loaded http://localhost:59329/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59329/tests/kraken/driver.html?testName=audio-dft) 01:52:34 INFO - PROCESS | 18356 | RSS: Main: 190337024 01:52:34 INFO - PROCESS | 18356 | 01:52:37 INFO - PROCESS | 18356 | Cycle 1(1): loaded http://localhost:59329/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59329/tests/kraken/driver.html?testName=audio-fft) 01:52:38 INFO - PROCESS | 18356 | RSS: Main: 186257408 01:52:38 INFO - PROCESS | 18356 | 01:52:40 INFO - PROCESS | 18356 | Cycle 1(1): loaded http://localhost:59329/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59329/tests/kraken/driver.html?testName=audio-oscillator) 01:52:41 INFO - PROCESS | 18356 | RSS: Main: 186974208 01:52:41 INFO - PROCESS | 18356 | 01:52:43 INFO - PROCESS | 18356 | Cycle 1(1): loaded http://localhost:59329/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59329/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:52:44 INFO - PROCESS | 18356 | RSS: Main: 187518976 01:52:44 INFO - PROCESS | 18356 | 01:52:47 INFO - PROCESS | 18356 | Cycle 1(1): loaded http://localhost:59329/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59329/tests/kraken/driver.html?testName=imaging-darkroom) 01:52:48 INFO - PROCESS | 18356 | RSS: Main: 187543552 01:52:48 INFO - PROCESS | 18356 | 01:52:51 INFO - PROCESS | 18356 | Cycle 1(1): loaded http://localhost:59329/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59329/tests/kraken/driver.html?testName=imaging-desaturate) 01:52:52 INFO - PROCESS | 18356 | RSS: Main: 184254464 01:52:52 INFO - PROCESS | 18356 | 01:52:55 INFO - PROCESS | 18356 | Cycle 1(1): loaded http://localhost:59329/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59329/tests/kraken/driver.html?testName=json-parse-financial) 01:52:55 INFO - PROCESS | 18356 | RSS: Main: 186048512 01:52:55 INFO - PROCESS | 18356 | 01:52:57 INFO - PROCESS | 18356 | Cycle 1(1): loaded http://localhost:59329/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59329/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:52:58 INFO - PROCESS | 18356 | RSS: Main: 186920960 01:52:58 INFO - PROCESS | 18356 | 01:53:00 INFO - PROCESS | 18356 | Cycle 1(1): loaded http://localhost:59329/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59329/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:53:00 INFO - PROCESS | 18356 | RSS: Main: 186994688 01:53:00 INFO - PROCESS | 18356 | 01:53:02 INFO - PROCESS | 18356 | Cycle 1(1): loaded http://localhost:59329/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59329/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:53:03 INFO - PROCESS | 18356 | RSS: Main: 186998784 01:53:03 INFO - PROCESS | 18356 | 01:53:06 INFO - PROCESS | 18356 | Cycle 1(1): loaded http://localhost:59329/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59329/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:53:07 INFO - PROCESS | 18356 | RSS: Main: 187650048 01:53:07 INFO - PROCESS | 18356 | 01:53:10 INFO - PROCESS | 18356 | Cycle 1(1): loaded http://localhost:59329/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59329/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:53:10 INFO - PROCESS | 18356 | RSS: Main: 187469824 01:53:10 INFO - PROCESS | 18356 | 01:53:12 INFO - PROCESS | 18356 | Cycle 1(1): loaded http://localhost:59329/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59329/tests/kraken/driver.html?testName=ai-astar) 01:53:12 INFO - PROCESS | 18356 | RSS: Main: 188391424 01:53:12 INFO - PROCESS | 18356 | 01:53:12 INFO - PROCESS | 18356 | __start_tp_report 01:53:12 INFO - PROCESS | 18356 | _x_x_mozilla_page_load 01:53:12 INFO - PROCESS | 18356 | _x_x_mozilla_page_load_details 01:53:12 INFO - PROCESS | 18356 | |i|pagename|runs| 01:53:12 INFO - PROCESS | 18356 | |0;ai-astar;116;108;114;113;115;114;113;113;114;113 01:53:12 INFO - PROCESS | 18356 | |1;audio-beat-detection;163;132;165;194;132;155;155;135;195;132 01:53:12 INFO - PROCESS | 18356 | |2;audio-dft;163;166;167;170;163;163;163;164;162;163 01:53:12 INFO - PROCESS | 18356 | |3;audio-fft;78;77;76;159;79;78;77;77;159;77 01:53:12 INFO - PROCESS | 18356 | |4;audio-oscillator;87;87;148;88;87;87;139;87;87;133 01:53:12 INFO - PROCESS | 18356 | |5;imaging-gaussian-blur;118;118;118;184;117;118;117;121;119;125 01:53:12 INFO - PROCESS | 18356 | |6;imaging-darkroom;150;148;147;149;148;148;149;151;149;147 01:53:12 INFO - PROCESS | 18356 | |7;imaging-desaturate;96;97;96;96;96;96;95;100;97;96 01:53:12 INFO - PROCESS | 18356 | |8;json-parse-financial;65;65;65;64;65;65;64;64;65;65 01:53:12 INFO - PROCESS | 18356 | |9;json-stringify-tinderbox;64;65;64;65;67;66;65;65;65;65 01:53:12 INFO - PROCESS | 18356 | |10;stanford-crypto-aes;84;83;85;83;86;84;90;86;112;85 01:53:12 INFO - PROCESS | 18356 | |11;stanford-crypto-ccm;143;141;143;129;135;131;145;145;142;134 01:53:12 INFO - PROCESS | 18356 | |12;stanford-crypto-pbkdf2;172;177;171;168;174;170;174;174;170;168 01:53:12 INFO - PROCESS | 18356 | |13;stanford-crypto-sha256-iterative;69;68;68;68;70;67;67;67;67;67 01:53:12 INFO - PROCESS | 18356 | __end_tp_report 01:53:12 INFO - PROCESS | 18356 | __start_cc_report 01:53:12 INFO - PROCESS | 18356 | _x_x_mozilla_cycle_collect,965 01:53:12 INFO - PROCESS | 18356 | __end_cc_report 01:53:12 INFO - PROCESS | 18356 | __startTimestamp1466499192620__endTimestamp 01:53:12 INFO - PROCESS | 18356 | 01:53:12 INFO - PROCESS | 18356 | ------- Summary: start ------- 01:53:12 INFO - PROCESS | 18356 | Number of tests: 14 01:53:12 INFO - PROCESS | 18356 | 01:53:12 INFO - PROCESS | 18356 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:2.11 (1.9%) stddev-sans-first:2.00 01:53:12 INFO - PROCESS | 18356 | Values: 116.0 108.0 114.0 113.0 115.0 114.0 113.0 113.0 114.0 113.0 01:53:12 INFO - PROCESS | 18356 | 01:53:12 INFO - PROCESS | 18356 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:159.00 stddev:24.19 (15.2%) stddev-sans-first:25.51 01:53:12 INFO - PROCESS | 18356 | Values: 163.0 132.0 165.0 194.0 132.0 155.0 155.0 135.0 195.0 132.0 01:53:12 INFO - PROCESS | 18356 | 01:53:12 INFO - PROCESS | 18356 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:2.50 (1.5%) stddev-sans-first:2.60 01:53:12 INFO - PROCESS | 18356 | Values: 163.0 166.0 167.0 170.0 163.0 163.0 163.0 164.0 162.0 163.0 01:53:12 INFO - PROCESS | 18356 | 01:53:12 INFO - PROCESS | 18356 | [#3] audio-fft Cycles:10 Average:93.70 Median:77.00 stddev:34.43 (44.7%) stddev-sans-first:36.04 01:53:12 INFO - PROCESS | 18356 | Values: 78.0 77.0 76.0 159.0 79.0 78.0 77.0 77.0 159.0 77.0 01:53:12 INFO - PROCESS | 18356 | 01:53:12 INFO - PROCESS | 18356 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:87.00 stddev:25.78 (29.6%) stddev-sans-first:26.69 01:53:12 INFO - PROCESS | 18356 | Values: 87.0 87.0 148.0 88.0 87.0 87.0 139.0 87.0 87.0 133.0 01:53:12 INFO - PROCESS | 18356 | 01:53:12 INFO - PROCESS | 18356 | [#5] imaging-gaussian-blur Cycles:10 Average:125.50 Median:118.50 stddev:20.69 (17.5%) stddev-sans-first:21.77 01:53:12 INFO - PROCESS | 18356 | Values: 118.0 118.0 118.0 184.0 117.0 118.0 117.0 121.0 119.0 125.0 01:53:12 INFO - PROCESS | 18356 | 01:53:12 INFO - PROCESS | 18356 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:1.26 (0.8%) stddev-sans-first:1.24 01:53:12 INFO - PROCESS | 18356 | Values: 150.0 148.0 147.0 149.0 148.0 148.0 149.0 151.0 149.0 147.0 01:53:12 INFO - PROCESS | 18356 | 01:53:12 INFO - PROCESS | 18356 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 01:53:12 INFO - PROCESS | 18356 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 95.0 100.0 97.0 96.0 01:53:12 INFO - PROCESS | 18356 | 01:53:12 INFO - PROCESS | 18356 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 01:53:12 INFO - PROCESS | 18356 | Values: 65.0 65.0 65.0 64.0 65.0 65.0 64.0 64.0 65.0 65.0 01:53:12 INFO - PROCESS | 18356 | 01:53:12 INFO - PROCESS | 18356 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 01:53:12 INFO - PROCESS | 18356 | Values: 64.0 65.0 64.0 65.0 67.0 66.0 65.0 65.0 65.0 65.0 01:53:12 INFO - PROCESS | 18356 | 01:53:12 INFO - PROCESS | 18356 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:85.00 stddev:8.74 (10.3%) stddev-sans-first:9.16 01:53:12 INFO - PROCESS | 18356 | Values: 84.0 83.0 85.0 83.0 86.0 84.0 90.0 86.0 112.0 85.0 01:53:12 INFO - PROCESS | 18356 | 01:53:12 INFO - PROCESS | 18356 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:142.50 stddev:5.98 (4.2%) stddev-sans-first:6.14 01:53:12 INFO - PROCESS | 18356 | Values: 143.0 141.0 143.0 129.0 135.0 131.0 145.0 145.0 142.0 134.0 01:53:12 INFO - PROCESS | 18356 | 01:53:12 INFO - PROCESS | 18356 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:173.00 stddev:2.94 (1.7%) stddev-sans-first:3.11 01:53:12 INFO - PROCESS | 18356 | Values: 172.0 177.0 171.0 168.0 174.0 170.0 174.0 174.0 170.0 168.0 01:53:12 INFO - PROCESS | 18356 | 01:53:12 INFO - PROCESS | 18356 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.03 (1.5%) stddev-sans-first:1.00 01:53:12 INFO - PROCESS | 18356 | Values: 69.0 68.0 68.0 68.0 70.0 67.0 67.0 67.0 67.0 67.0 01:53:12 INFO - PROCESS | 18356 | -------- Summary: end -------- 01:53:12 INFO - PROCESS | 18356 | 01:53:13 INFO - TEST-INFO | 18356: exit 0 01:53:13 INFO - TEST-OK | kraken | took 64092ms 01:53:13 INFO - SUITE-END | took 1180s 01:53:13 INFO - Completed test suite (00:19:40) 01:53:13 INFO - javascript benchmark 01:53:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6458.298796344822, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2622.8032897532685, 2689.67723873135, 2690.569508878579, 2722.020072773801, 2722.9455410891783, 4766.404199475061, 4824.589909857662, 4845.127876982142, 4874.6831455955335, 4896.412430508344, 4761.381020467343, 4816.229403295473, 4821.8794530136765, 4890.021995600885, 4971.204607262839, 4338.479382474107, 4363.280058790296, 4372.825086996516, 4493.415855938723, 4528.660350473711, 4426.490953540336, 4497.370368148462, 4505.662075344346, 4513.593776560109, 4536.455625324949, 4343.869683909487, 4394.780260986938, 4408.448943882015, 4459.710118842281, 4461.821527138911, 4401.889952751175, 4409.867703968886, 4413.6910416270875, 4416.911661766747, 4445.799939002753, 4435.933460998088, 4443.955670417449, 4444.222261104326, 4448.399466072071, 4491.146682130385, 4831.323614693945, 4879.4388645305535, 4902.950970490321, 4914.164592019365, 4938.0, 5292.311999440049, 5293.285406470154, 5305.442928492491, 5313.1764576490705, 5319.015982043335, 5356.11624082026, 5363.919541206885, 5372.677639341613, 5373.704446255454, 5375.623706340558, 4842.12841688496, 4899.804007839718, 4941.061198372297, 4946.752662366867, 4967.907060446696, 5439.809606663748, 5444.074507333763, 5475.315585551806, 5479.123340265618, 5488.945110548843, 5094.981003799255, 5228.843134705965, 5229.137192363218, 5232.712200828991, 5265.76304066318, 5085.974570127126, 5208.348956380452, 5244.108501554745, 5255.921161182585, 5262.578993680497, 5238.476152384731, 5263.131583288791, 5313.654612450256, 5313.973430132824, 5315.946840531546, 5017.397912250553, 5254.605904557174, 5258.947410525846, 5259.684418934876, 5298.655587386807, 4417.646588272931, 4426.114777044604, 4447.132809102259, 4448.621867141264, 4455.933161002587, 3839.2897313997, 3855.9807200963814, 3869.6323849234277, 3898.766074035567, 3904.707146963989, 4447.822087116479, 4464.799084041161, 4475.664325175625, 4537.410136682211, 4574.5425457453985, 5236.423993360727, 5253.369595648546, 5254.710990895461, 5272.841814745564, 5318.202269659582, 4453.599176074169, 4499.21263778844, 4509.7970591323465, 4510.954890451119, 4545.477270113913, 4651.325557794168, 4711.882202944954, 4716.858494245178, 4757.8096876125255, 4759.16714574948, 4932.53140951609, 4973.45292017885, 4973.651844370859, 5003.44962054181, 5025.974870125699, 5320.201969704421, 5324.307839980933, 5325.840224793263, 5342.786288548415, 5378.1663842104535, 4868.732219727807, 4910.533499317559, 4937.876553086058, 4969.229769385751, 4995.225740010304, 5190.065788158167, 5212.113940630026, 5216.191490319006, 5217.321748172713, 5220.738963051908, 5290.7883684653725, 5295.232191332312, 5295.735213239245, 5298.28473156119, 5342.198670199501, 4954.702717836942, 5027.2207807789855, 5093.0577843099145, 5093.541581257705, 5106.897862042664, 5023.045621331935, 5025.120603894377, 5028.723420211777, 5076.0, 5088.465711100281, 4987.301777751045, 5006.048850718352, 5027.974860125676, 5033.245013247895, 5070.163423035306, 5078.4667609900425, 5156.04613146569, 5159.561437277874, 5183.766730497212, 5205.947940520698, 5027.296178535081, 5051.520105589963, 5075.1625981712605, 5095.796168153232, 5155.123628983157], "value": 4809.575951533513, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.5249419450574, 583.1078449971544, 588.179489611991, 599.0564860344956, 602.2231321595142, 35010.0, 38517.61482385182, 38523.22953540928, 38578.421323680166, 38752.22495550091, 38786.8060659697, 39305.0, 39336.80331598345, 39364.409533856946, 39364.40953385702, 7740.612969351538, 7848.2151784821635, 7869.960650196741, 7876.921230787676, 7881.369490440751, 7821.5307081575, 7871.9212807872045, 7879.212078792132, 7880.054393472791, 7894.131645518988, 7877.409194310421, 7882.054153501559, 7900.091489478697, 7908.0, 7910.920890791076, 7808.726694565663, 7840.921590784076, 7848.607569621525, 7858.17489163641, 7865.174156713577, 7821.921780782176, 7872.763817085496, 7888.211178882066, 7897.328727058207, 7917.0, 37234.81382593097, 37657.81171094155, 37691.62308376909, 37743.43384849229, 37763.433548496796, 2525.494901019785, 2897.985510072457, 2975.747061499775, 2998.580198772174, 3029.106413607991, 27374.863125684442, 27793.02724404636, 27995.300117497023, 28183.859080704464, 28861.56707649387, 3173.1591128351006, 3203.2952750394875, 3225.5645487859074, 3266.803991760502, 3274.8690052397874, 201993.0, 255384.0, 256609.0, 256851.0, 256859.0, 54449.45550544523, 55244.17133742997, 55334.72332638311, 55355.0, 55432.72283638556, 32917.67082329194, 33657.66342336594, 33693.663063369546, 35594.0, 35600.0, 13293.335333233299, 13573.049886508046, 13574.185548867099, 13615.25116118623, 13686.878533827272, 10009.749756256151, 10138.03688649577, 10180.134688551556, 10237.078662920225, 10245.795084098425, 17940.730889036677, 18170.81829181691, 18310.450686479428, 18322.63354732898, 18346.724799128024, 6974.884018557006, 6985.0, 7021.719131234796, 7103.964480177669, 7114.608696521741, 782.0927723840318, 882.8278485695228, 954.1841725324886, 986.2405947420447, 1005.7083445800782, 27587.448251034868, 27981.86009069982, 28222.29444263869, 28478.71521284802, 28705.56941645877, 994.3387647214666, 996.1731762636994, 1019.9439030853226, 1034.4310629153936, 1064.302881612545, 14372.209528475825, 14946.40214391434, 15030.0, 15163.772543411858, 15170.469033583771, 401469.0, 405179.0, 405979.0, 406205.0, 406341.0, 48158.518414816106, 49455.75272123688, 49511.752441238285, 49783.0, 49984.25023624649, 1193.797054500737, 1202.7955247607927, 1202.8857258560422, 1210.1589395370308, 1216.6775804411839, 26910.770707515225, 27283.181504554894, 27518.0, 27558.72441275642, 28016.719832801413, 37277.440838387985, 37448.812755937135, 37602.811985939894, 37735.62264377431, 37890.0, 259301.0, 261045.0, 261534.0, 261781.0, 262637.0, 25282.873585631954, 25383.857726402726, 26302.605460918483, 26382.0, 27364.315892102855, 41143.55997540072, 41332.79333603313, 42362.36456453094, 42382.0, 42654.0, 35635.64364356427, 35769.0, 36210.63789362178, 36352.09119771921, 36639.0, 35053.0, 35092.473612896334, 35313.47029794504, 35386.1153471155, 35589.0, 35424.46863297104, 35666.821665892545, 35997.1000724984, 37134.8143259282, 37152.81423592865, 30263.394732104793, 31936.840315798272, 32428.67571324351, 32451.837740811145, 32541.0, 25052.74947250577, 25208.722617580526, 25368.365790855376, 25441.872790635927, 26071.478570428866], "value": 17059.942611259146, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.8284947499412, 371.44469018816875, 371.7639299045106, 382.78084301499706, 386.56897559221477, 15582.142982135992, 17219.827801721978, 17413.216405261763, 17769.46691599254, 17808.821911780877, 16180.919095404535, 16362.0, 17095.230714617843, 17182.656346873056, 17236.569085772862, 5056.165732654108, 5258.237555554442, 5289.0, 5294.947050529503, 5306.442823503515, 3666.615005424432, 5185.844424667266, 5857.150713146591, 6165.260168779752, 6173.259208894939, 6201.1008403781425, 6205.162303089093, 6206.906896396557, 6228.408301211378, 6258.968705156468, 5066.088104141253, 5386.084365657828, 5387.568994480433, 5434.510894019518, 5445.37378201504, 5172.741362931876, 5236.371635403738, 5239.816606418757, 5257.158854583248, 5305.336832895888, 12117.818232726517, 12463.376831158406, 12484.438200280918, 19911.303104391423, 20023.934968392994, 1890.0, 1892.7350170976074, 1929.199382256362, 1940.922363105474, 2039.694045893113, 8983.775405614846, 9071.546422678839, 9254.722358329262, 9275.721728348093, 9879.308448408614, 1787.5977904971407, 1887.9150438230313, 2030.5837303352926, 2096.423483542023, 2120.766715661276, 78996.07529435316, 79897.20102798956, 80811.5959420205, 81010.18989810086, 81891.5905420469, 15956.122413267381, 16562.0, 16623.91688041552, 16679.833201668072, 16780.0, 29177.0, 29244.0, 29362.853185733933, 29413.11760647184, 29831.40337193244, 7822.687092516349, 8164.142765009708, 8253.0, 8357.788120722462, 8393.24460798531, 6462.773802916875, 6515.478761699147, 6518.44593209573, 6782.084418603524, 6794.9660251699415, 8291.95854020726, 8413.242808147173, 8437.746867593982, 8531.616077276538, 8587.613557389932, 1506.6534697019747, 1586.2465328968647, 1594.3144447887287, 1614.862736667373, 3100.6279246490567, 817.9591020448954, 863.2403484933219, 867.098217853438, 897.9955100224457, 933.1415098109755, 16083.919580402024, 16314.510564683078, 16408.917955410147, 16563.171841408122, 16690.58273543171, 797.8005498625344, 843.5444859775653, 846.331398195431, 863.4948555095214, 895.7312806158127, 8681.91318086811, 9059.728208153765, 9355.0, 9376.437413755197, 9522.761930951781, 301943.0, 385672.0, 388605.0, 393552.0, 430006.0, 72398.63800681068, 81447.59276203581, 85341.57329213314, 87067.0, 87632.56183719041, 423.7288135593223, 437.46847580190223, 437.9167958087953, 438.9275769497997, 439.2620397731777, 9455.669051583161, 10211.591536338761, 10216.387016779017, 10247.641332553325, 10442.373457592568, 36104.27791444209, 36859.0, 37569.4364584526, 37893.0, 38317.616823831406, 51010.74494627503, 52632.0, 52710.209346860596, 52805.0, 52849.47150528599, 7274.599897005715, 7791.571463569331, 7796.688132474637, 7846.254605812439, 7883.802904927423, 9005.63977440895, 11801.35092569917, 11823.11326650522, 11950.087985922211, 12047.277163370225, 9903.405795652285, 9945.353552019096, 10188.745281368025, 10254.6410875619, 10589.205809564159, 10090.848637270594, 10308.350663893742, 10529.0, 10572.20708446885, 10579.0, 10274.308774608679, 10443.791124177626, 10497.0, 10646.520906559379, 10844.132469402586, 7574.204708505748, 7591.430642701709, 7686.538807671557, 7733.845323093619, 7794.92205077942, 10253.231007674305, 10332.431716255678, 10429.217808664229, 10463.947680261854, 10483.633072842415], "value": 8455.219202426235, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1247.1270110922353, 1331.9001074919383, 1359.3814814259513, 1657.8839481236319, 1701.863850891928, 6530.738770449188, 7321.816954576125, 7360.705571777129, 7901.091374491928, 7906.723264685737, 7410.147832999207, 7651.043619547557, 7697.114831794332, 7703.807404814883, 7707.30634242918, 2132.4775430019627, 2192.9232476863313, 2193.254293540196, 2195.056125865877, 2199.1643175593254, 2168.5988092202915, 2176.2056849250066, 2212.2478357358495, 2215.601191785478, 2222.899969501368, 2143.839212059094, 2163.9134434622597, 2170.066871245364, 2174.8260139188906, 2194.7695491973354, 2048.4366799130207, 2055.7973585452455, 2056.7634722006937, 2058.752949646037, 2060.7527096748336, 2130.669746189343, 2163.6754486826944, 2168.1002384010617, 2170.2295685031904, 2170.305502239284, 7581.3934885209055, 7706.884396734054, 7790.104138024143, 7797.259260370256, 7802.180771019075, 4378.452693413324, 4483.798229079699, 4506.459224893034, 4519.774011299455, 4529.0715403342565, 2731.399092199713, 2836.078274560776, 2841.1476557033016, 2905.7094290570985, 2909.1999700082433, 833.9082700902895, 845.5729856422467, 883.8895138107737, 884.1909652667802, 887.2148148888216, 10268.486575671186, 10324.690259292232, 10335.586576536929, 10338.0, 10341.63804266847, 3958.7822669752863, 4003.3394489908837, 4057.634812866797, 4143.7306575072525, 4143.751374917515, 8922.197002269826, 8937.06160853101, 8944.776380590407, 8952.776180595538, 8971.282297416192, 4464.888377790517, 4530.22986092365, 4537.160625284333, 4544.113897789965, 4547.15877562652, 3497.4753786931656, 4007.1184339445276, 4115.34154535273, 4170.77060761655, 4240.151969606091, 3562.679358857715, 3571.9285614288087, 3649.379605467077, 3678.2275722098657, 3716.089558058293, 1122.4912320962642, 1148.121686909515, 1177.8881006304387, 1181.173178774861, 1188.2276520261898, 680.4556354916048, 736.3961551527696, 812.5246730662628, 827.4042689263721, 843.0894633795486, 5023.472535383805, 5053.949460505348, 5154.201098829687, 5165.431802501722, 5281.762320695501, 827.2720006394335, 836.7782537627534, 865.0095640491602, 884.2793123604242, 898.7483504618717, 3203.51947207916, 3256.316173603522, 3268.4280250956463, 3289.013296011187, 3289.210589458513, 8634.5251011195, 9062.637494500146, 9357.438553686801, 9368.156865882103, 9393.201577865959, 8981.595828187747, 9124.905011398541, 9174.816503669888, 9221.49281789508, 9232.215261702697, 7039.54242974205, 7086.078809754802, 7146.428285737128, 7200.891986620205, 7329.853402932018, 5063.87340316495, 5204.245384419314, 5329.147336426308, 5368.1679339702405, 5470.425605311385, 8380.53907035119, 8598.355123365647, 8615.741527754177, 8696.521691307038, 8714.825703485769, 8577.8713319299, 8908.287337013153, 8930.687425940061, 9016.729498115066, 9076.137766912132, 5753.482186603226, 6446.613203207822, 6507.511936604679, 6654.035164900965, 6680.365365290289, 7438.814029649302, 7493.213212612597, 7502.3622992046285, 7509.6245187739305, 7593.658285377061, 6459.160309159779, 6634.170728658918, 6667.733290668319, 6705.664716764045, 6714.630695311805, 6378.649174295459, 6402.839929001812, 6494.155759751202, 6590.47276217911, 6645.1361323027695, 6298.748050077946, 6304.3380445054445, 6333.809985700436, 6349.8730025400155, 6358.109864619049, 4490.191765482245, 4494.1461122386645, 4585.495595484561, 4637.884052898705, 4656.208444564364, 4265.9360109599, 4329.6969212154845, 4420.77896105187, 4484.439445069366, 4516.299973504112], "value": 4041.053575192199, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.18458132647265, 293.14109658700016, 297.64431504352297, 299.5985379591347, 303.9118655589879, 5087.2114822202575, 5141.22881567765, 5142.6914385136915, 5160.277561141444, 5168.121419358708, 5003.449620541746, 5007.672966663837, 5011.4737952514915, 5028.773705183266, 5055.696658200511, 3936.960630393688, 3948.763074215542, 3968.6386599973116, 3969.3450580654157, 3975.6819454443576, 3638.472421498881, 3887.8056097195026, 3987.940180897289, 3998.9600103999023, 4004.8786339824896, 3788.2423515296914, 3816.026913137146, 3817.618238176188, 3824.388097904336, 3831.942520862189, 3809.5428548574073, 3824.4072168813877, 3828.406596977473, 3828.578856325802, 3828.674562662163, 3204.6955539223736, 3278.442664746975, 3320.8671653133847, 3373.510840928076, 3377.240120972786, 4987.077390682735, 4989.501049895018, 5035.269885866565, 5041.571466425358, 5048.318477005594, 4436.534163912775, 4462.754548499831, 4469.41897553316, 4505.3917721107555, 4508.827704796744, 5108.667936584147, 5376.731163441851, 5379.220013098079, 5402.594805389612, 5409.350877894639, 3673.210259794157, 3684.042149041242, 3695.5380577427823, 3700.7039436845257, 3725.2921944830396, 5542.584306177053, 5627.943720562824, 5632.324121105453, 5635.436456354331, 5660.490555849993, 3560.1989552351033, 3762.6237376262156, 3787.223619158066, 3792.8482860685262, 3793.5637401698605, 3868.864589739346, 3874.12832112778, 3875.5736868944396, 3890.0858298299877, 3891.5135608048995, 4378.190034843564, 4447.66497588762, 4459.241928872099, 4466.397036400044, 4491.550844915548, 5217.478252174828, 5358.732063396893, 5417.566594672417, 5432.837014889559, 5498.615096943256, 1325.4698120751777, 1352.0265408905573, 1352.7362164377853, 1352.8850047746052, 1354.5056054540023, 819.4264015189273, 831.1854382704862, 845.3068483843313, 849.7918010087568, 856.4818284937647, 4271.829126834954, 4291.54938731435, 4320.935185972213, 4321.956780432219, 4346.587074227943, 4863.10032643962, 5023.522765337287, 5038.571721403649, 5047.747612619354, 5061.44324124346, 4209.24233637942, 4234.957650423518, 4315.244832154361, 4315.287977483743, 4316.072044510445, 2492.2772396004957, 2590.663213782196, 2598.402367455496, 2812.774978001755, 2889.7832662550395, 5177.378714554277, 5201.531862132426, 5210.609204309616, 5228.241904923765, 5235.842924712265, 5638.026690658319, 5640.323161220597, 5658.519025882846, 5674.971625141848, 5693.345265294462, 4967.950320496749, 5156.4070131935305, 5203.401608815035, 5212.270282160424, 5224.686518808883, 5531.8893622128135, 5551.306086739158, 5554.638948468337, 5558.471945165203, 5562.860928476821, 5336.599755018312, 5375.784968601369, 5389.83830485086, 5404.432714512747, 5443.891122177455, 4943.530364615356, 5252.896891652796, 5254.927431240666, 5264.184051472028, 5277.894442111059, 3797.525309336333, 3865.7487263327794, 3873.8450461981206, 3895.610438956195, 3918.451416801593, 5456.345238571397, 5632.633878797865, 5633.295838020247, 5649.519790817826, 5698.0, 5398.892022159614, 5426.267453893832, 5432.483914028161, 5447.727613619224, 5457.372402173801, 5354.36691809002, 5425.233131103087, 5440.6735595864375, 5443.482869127427, 5452.945470545244, 5085.949140508547, 5180.404253510744, 5218.060749065205, 5259.789608415621, 5311.326033090855, 5465.699386533779, 5469.562435005269, 5474.972625136849, 5515.200295957144, 5521.806736764194, 5363.659085228693, 5408.269883565826, 5410.75651595687, 5444.754986025559, 5447.291852059207], "value": 3959.1021071963683, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.2247213455315, 628.0735914526075, 632.9208848893888, 657.132584987816, 718.052171134103, 11748.647540573775, 12205.450754716037, 13017.934910325446, 13317.467301307948, 14093.295335233248, 13949.30253487324, 14082.71834563308, 14172.433102675906, 14177.149371037745, 14187.432502699905, 797.9441439099265, 805.9395545334094, 806.2501873257868, 806.2662976691212, 808.0101875202859, 790.3361176611645, 791.0507391130637, 791.9326857217144, 794.5153456391597, 795.6021989005498, 838.8741688746676, 842.4481964313385, 843.4981186194235, 844.3920377328313, 846.7713717296357, 790.8141586727114, 822.9629666665014, 826.3389288569151, 830.7466222802043, 834.5451728807815, 591.7130191856946, 594.1711312718733, 596.3470000349654, 598.7036416973582, 599.0505049496553, 13930.024898257127, 13970.860291397057, 13982.230977296347, 14025.78961315581, 14038.298085095705, 12849.164804287784, 13303.04253167337, 13468.945293961948, 13515.932420337933, 13658.726825463535, 10882.29265097766, 10944.124470042378, 11001.394923279217, 11032.22774405792, 11130.08328396692, 3336.182635254378, 3348.598168219805, 3350.832458377096, 3368.5620869286836, 3419.4870769384543, 67313.3268667312, 67463.0, 67465.66267168682, 68238.65880670614, 68368.31631683718, 10553.47232638365, 10713.892861071445, 10718.571257149626, 10719.678409647722, 10799.730006749736, 19095.42713718563, 19183.80816191848, 19232.134553945107, 19304.1313140909, 19568.902155489417, 6569.58283149017, 6672.699728512229, 6686.1642294713165, 6691.5650482718465, 6800.455963523005, 3722.1253005543676, 3737.5141231639714, 3738.4392341149046, 3744.6068162843053, 3789.5831458539537, 2969.287371030937, 3077.8461076946064, 3085.5371694245596, 3087.012156110023, 3090.0884239149505, 502.2366003674467, 507.401266505527, 511.2484647568069, 512.4337606944347, 515.5411683601598, 567.8410045187354, 595.238095238096, 598.3627436779902, 603.6559161278029, 615.8429600451856, 8065.792026746663, 8135.267825895698, 8316.293115085164, 8395.286400656012, 8768.912310876936, 464.6538328944958, 572.5276646766351, 594.6342999055549, 611.9418655227746, 623.8190924631897, 3574.267275208576, 3860.285847118292, 3941.2905676977844, 3975.4831871856472, 4022.336314508132, 106193.46903265589, 107064.0, 107401.4629926861, 108370.0, 109000.0, 91980.54009729909, 92203.53898230466, 92584.07415925755, 92651.0, 92653.0, 48278.75860620745, 51216.0, 77391.0, 86984.56507717421, 88762.0, 7420.703171873281, 7474.7757567273065, 7622.847543049219, 7767.805804854924, 7770.805729856799, 46891.296630549885, 47802.28296575624, 47822.76088619535, 47945.28082078702, 48817.0, 62789.37210627835, 67089.0, 67357.3264267351, 67404.3259567398, 67558.0, 9396.624135034523, 9916.851247231441, 9951.850722239027, 10009.749756256151, 10012.998700129929, 11286.774264514828, 11492.36791976416, 11545.249558778652, 11879.940600296943, 11918.106142039209, 9440.669576564787, 9476.241900648069, 9803.754906127118, 10327.0, 10640.627578034731, 9277.907220927704, 9781.706548803548, 9787.951060244937, 9857.704268871945, 10262.58949642006, 10154.746131346776, 10356.585736570754, 10375.429351385746, 10385.169186465217, 10425.582976680847, 9176.6788162414, 9227.984921658477, 9749.853752193865, 9759.9024009759, 9795.853062204214, 8811.559422029, 9175.174234318943, 9242.815143696955, 9246.398984066014, 9358.4384936904], "value": 6536.737345645973, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1596.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 108.0, 114.0, 113.0, 115.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 165.0, 194.0, 132.0, 155.0, 155.0, 135.0, 195.0, 132.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 167.0, 170.0, 163.0, 163.0, 163.0, 164.0, 162.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 76.0, 159.0, 79.0, 78.0, 77.0, 77.0, 159.0, 77.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 148.0, 88.0, 87.0, 87.0, 139.0, 87.0, 87.0, 133.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 184.0, 117.0, 118.0, 117.0, 121.0, 119.0, 125.0], "value": 125.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 147.0, 149.0, 148.0, 148.0, 149.0, 151.0, 149.0, 147.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 100.0, 97.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 67.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 85.0, 83.0, 86.0, 84.0, 90.0, 86.0, 112.0, 85.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 141.0, 143.0, 129.0, 135.0, 131.0, 145.0, 145.0, 142.0, 134.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 177.0, 171.0, 168.0, 174.0, 170.0, 174.0, 174.0, 170.0, 168.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 68.0, 70.0, 67.0, 67.0, 67.0, 67.0, 67.0], "value": 67.8, "unit": "score"}]}]} 01:53:13 INFO - Return code: 0 01:53:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:53:13 ERROR - # TBPL SUCCESS # 01:53:13 INFO - Running post-action listener: _resource_record_post_action 01:53:13 INFO - ##### 01:53:13 INFO - ##### Finished run-tests step (success) 01:53:13 INFO - ##### 01:53:13 INFO - Running post-run listener: _resource_record_post_run 01:53:13 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547598336; Read time: 12; Write time: 361420 01:53:13 INFO - TinderboxPrint: CPU usage
13.5% 01:53:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 01:53:13 INFO - TinderboxPrint: I/O write bytes / time
547,598,336 / 361,420 01:53:13 INFO - TinderboxPrint: CPU idle
8,268.4 (86.5%) 01:53:13 INFO - TinderboxPrint: CPU user
1,233.7 (12.9%) 01:53:13 INFO - TinderboxPrint: Swap in / out
0 / 0 01:53:13 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252014592; Read time: 0; Write time: 212852 01:53:14 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295583744; Read time: 12; Write time: 148568 01:53:14 INFO - Running post-run listener: _upload_blobber_files 01:53:14 INFO - Blob upload gear active. 01:53:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:53:14 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 01:53:14 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'] 01:53:14 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 01:53:14 INFO - (blobuploader) - INFO - Open directory for files ... 01:53:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:53:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:53:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:15 INFO - (blobuploader) - INFO - Done attempting. 01:53:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:53:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:53:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:18 INFO - (blobuploader) - INFO - Done attempting. 01:53:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:53:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:53:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:19 INFO - (blobuploader) - INFO - Done attempting. 01:53:19 INFO - (blobuploader) - INFO - Iteration through files over. 01:53:19 INFO - Return code: 0 01:53:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:53:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:53:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/77b7b895b709ae7532547cbcf3f3f1c2d353202191ef5597ef38e2d09f3e1b9d99b2cf185033c75c422da0a20aea94b52cfd6758667bfd60de9ca86621a0d838", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73fd682632c9e6194fb4f871acb523163b8179bf85b4734517f11017ac04617680a7774f1c6f4a47420b15c78141aa0eaab9d9c77ec1eb562aa2868cccb774a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad365fb18ce6a8dca83f77e4b5b106e6071ee34b30813f9ad4aa612d84cadc1240a52668dcb488145f339f51d271fcccf3541cb350811ba1c85d83c42306ea01"} 01:53:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:53:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:53:19 INFO - Contents: 01:53:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/77b7b895b709ae7532547cbcf3f3f1c2d353202191ef5597ef38e2d09f3e1b9d99b2cf185033c75c422da0a20aea94b52cfd6758667bfd60de9ca86621a0d838", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73fd682632c9e6194fb4f871acb523163b8179bf85b4734517f11017ac04617680a7774f1c6f4a47420b15c78141aa0eaab9d9c77ec1eb562aa2868cccb774a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad365fb18ce6a8dca83f77e4b5b106e6071ee34b30813f9ad4aa612d84cadc1240a52668dcb488145f339f51d271fcccf3541cb350811ba1c85d83c42306ea01"} 01:53:19 INFO - Running post-run listener: copy_logs_to_upload_dir 01:53:19 INFO - Copying logs to upload dir... 01:53:19 INFO - mkdir: /builds/slave/test/build/upload/logs 01:53:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.871519 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-06-21 01:53:19.599379) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 01:53:19.602547) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311 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/77b7b895b709ae7532547cbcf3f3f1c2d353202191ef5597ef38e2d09f3e1b9d99b2cf185033c75c422da0a20aea94b52cfd6758667bfd60de9ca86621a0d838", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73fd682632c9e6194fb4f871acb523163b8179bf85b4734517f11017ac04617680a7774f1c6f4a47420b15c78141aa0eaab9d9c77ec1eb562aa2868cccb774a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad365fb18ce6a8dca83f77e4b5b106e6071ee34b30813f9ad4aa612d84cadc1240a52668dcb488145f339f51d271fcccf3541cb350811ba1c85d83c42306ea01"} build_url:https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011520 build_url: 'https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/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/77b7b895b709ae7532547cbcf3f3f1c2d353202191ef5597ef38e2d09f3e1b9d99b2cf185033c75c422da0a20aea94b52cfd6758667bfd60de9ca86621a0d838", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73fd682632c9e6194fb4f871acb523163b8179bf85b4734517f11017ac04617680a7774f1c6f4a47420b15c78141aa0eaab9d9c77ec1eb562aa2868cccb774a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad365fb18ce6a8dca83f77e4b5b106e6071ee34b30813f9ad4aa612d84cadc1240a52668dcb488145f339f51d271fcccf3541cb350811ba1c85d83c42306ea01"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 01:53:19.629735) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:53:19.630060) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466497371.836937-615713311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004580 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:53:19.713688) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 01:53:19.714376) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 01:53:19.714827) ========= ========= Total master_lag: 0.18 =========