builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1465463406.88 results: success (0) buildid: 20160608233033 builduid: 6ed1ef468a554f849a6e001d1fea6907 revision: f8bdceb55c9d191380176ab25e2385737bd9e1ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 02:10:06.882186) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 02:10:06.882725) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 02:10:06.883018) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 02:10:06.898658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:10:06.899069) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 02:10:07-- 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% 219M=0s 2016-06-09 02:10:07 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113315 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:10:07.026167) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:10:07.026488) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014217 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:10:07.076498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 02:10:07.076870) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f8bdceb55c9d191380176ab25e2385737bd9e1ab --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 f8bdceb55c9d191380176ab25e2385737bd9e1ab --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=14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 02:10:07,248 truncating revision to first 12 chars 2016-06-09 02:10:07,249 Setting DEBUG logging. 2016-06-09 02:10:07,249 attempt 1/10 2016-06-09 02:10:07,249 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f8bdceb55c9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 02:10:08,009 unpacking tar archive at: fx-team-f8bdceb55c9d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.135070 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 02:10:08.225849) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 02:10:08.226174) ========= script_repo_revision: f8bdceb55c9d191380176ab25e2385737bd9e1ab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 02:10:08.226577) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 02:10:08.226849) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 02:10:08.237425) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-09 02:10:08.237703) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:10:08 INFO - MultiFileLogger online at 20160609 02:10:08 in /builds/slave/test 02:10:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:10:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:10:08 INFO - {'append_to_log': False, 02:10:08 INFO - 'base_work_dir': '/builds/slave/test', 02:10:08 INFO - 'blob_upload_branch': 'Fx-Team', 02:10:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:10:08 INFO - 'branch': 'Fx-Team', 02:10:08 INFO - 'buildbot_json_path': 'buildprops.json', 02:10:08 INFO - 'config_files': ('talos/linux_config.py',), 02:10:08 INFO - 'default_actions': ('clobber', 02:10:08 INFO - 'read-buildbot-config', 02:10:08 INFO - 'download-and-extract', 02:10:08 INFO - 'populate-webroot', 02:10:08 INFO - 'create-virtualenv', 02:10:08 INFO - 'install', 02:10:08 INFO - 'run-tests'), 02:10:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:10:08 INFO - 'download_minidump_stackwalk': True, 02:10:08 INFO - 'download_symbols': 'ondemand', 02:10:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:10:08 INFO - 'tooltool.py': '/tools/tooltool.py', 02:10:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:10:08 INFO - '/tools/misc-python/virtualenv.py')}, 02:10:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:10:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:10:08 INFO - 'installer_path': 'installer.exe', 02:10:08 INFO - 'log_level': 'info', 02:10:08 INFO - 'log_name': 'talos', 02:10:08 INFO - 'log_to_console': True, 02:10:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:10:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:10:08 INFO - 'opt_config_files': (), 02:10:08 INFO - 'pip_index': False, 02:10:08 INFO - 'sps_profile': False, 02:10:08 INFO - 'sps_profile_interval': 0, 02:10:08 INFO - 'suite': 'dromaeojs-e10s', 02:10:08 INFO - 'system_bits': '32', 02:10:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:10:08 INFO - 'title': 'talos-linux64-ix-036', 02:10:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:10:08 INFO - 'use_talos_json': True, 02:10:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:10:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:10:08 INFO - 'work_dir': 'build'} 02:10:08 INFO - ##### 02:10:08 INFO - ##### Running clobber step. 02:10:08 INFO - ##### 02:10:08 INFO - Running pre-action listener: _resource_record_pre_action 02:10:08 INFO - Running main action method: clobber 02:10:08 INFO - rmtree: /builds/slave/test/build 02:10:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:10:08 INFO - Running post-action listener: _resource_record_post_action 02:10:08 INFO - ##### 02:10:08 INFO - ##### Finished clobber step (success) 02:10:08 INFO - ##### 02:10:08 INFO - ##### 02:10:08 INFO - ##### Running read-buildbot-config step. 02:10:08 INFO - ##### 02:10:08 INFO - Running pre-action listener: _resource_record_pre_action 02:10:08 INFO - Running main action method: read_buildbot_config 02:10:08 INFO - Using buildbot properties: 02:10:08 INFO - { 02:10:08 INFO - "project": "", 02:10:08 INFO - "product": "firefox", 02:10:08 INFO - "script_repo_revision": "production", 02:10:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:10:08 INFO - "repository": "", 02:10:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:10:08 INFO - "buildid": "20160608233033", 02:10:08 INFO - "pgo_build": "True", 02:10:08 INFO - "basedir": "/builds/slave/test", 02:10:08 INFO - "buildnumber": 444, 02:10:08 INFO - "slavename": "talos-linux64-ix-036", 02:10:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:10:08 INFO - "platform": "ubuntu64_hw", 02:10:08 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:10:08 INFO - "branch": "fx-team", 02:10:08 INFO - "repo_path": "integration/fx-team", 02:10:08 INFO - "revision": "f8bdceb55c9d191380176ab25e2385737bd9e1ab", 02:10:08 INFO - "stage_platform": "linux64-pgo", 02:10:08 INFO - "builduid": "6ed1ef468a554f849a6e001d1fea6907", 02:10:08 INFO - "slavebuilddir": "test" 02:10:08 INFO - } 02:10:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:10:08 INFO - Running post-action listener: _resource_record_post_action 02:10:08 INFO - ##### 02:10:08 INFO - ##### Finished read-buildbot-config step (success) 02:10:08 INFO - ##### 02:10:08 INFO - ##### 02:10:08 INFO - ##### Running download-and-extract step. 02:10:08 INFO - ##### 02:10:08 INFO - Running pre-action listener: _resource_record_pre_action 02:10:08 INFO - Running main action method: download_and_extract 02:10:08 INFO - mkdir: /builds/slave/test/build/tests 02:10: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')]} 02:10:08 INFO - https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:10:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:10:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:10:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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 02:10:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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 02:10:09 INFO - Downloaded 1361 bytes. 02:10:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:10:09 INFO - Using the following test package requirements: 02:10:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:10:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:10:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:10:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:09 INFO - u'jsshell-linux-x86_64.zip'], 02:10:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:10:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:10:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:10:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:10:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:10:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:10:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:10:09 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')]} 02:10:09 INFO - https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:10:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:10:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:10:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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 02:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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 02:10:10 INFO - Downloaded 24451237 bytes. 02:10:10 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'] 02:10:10 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 02:10:11 INFO - Return code: 0 02:10:11 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 02:10:11 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')]} 02:10:11 INFO - https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:10:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:10:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:10:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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 02:10:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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 02:10:13 INFO - Downloaded 24451237 bytes. 02:10:13 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'] 02:10:13 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 02:10:14 INFO - Return code: 0 02:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:14 INFO - https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:10:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:10:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:10:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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 02:10:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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 02:10:15 INFO - Downloaded 10833369 bytes. 02:10:15 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'] 02:10:15 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 02:10:16 INFO - Return code: 0 02:10:16 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')]} 02:10:16 INFO - https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:10:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:10:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:10:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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 02:10:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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 02:10:22 INFO - Downloaded 59319784 bytes. 02:10:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:10:22 INFO - mkdir: /builds/slave/test/properties 02:10:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:10:22 INFO - Writing to file /builds/slave/test/properties/build_url 02:10:22 INFO - Contents: 02:10:22 INFO - build_url:https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:10:22 INFO - Running post-action listener: _resource_record_post_action 02:10:22 INFO - Running post-action listener: set_extra_try_arguments 02:10:22 INFO - ##### 02:10:22 INFO - ##### Finished download-and-extract step (success) 02:10:22 INFO - ##### 02:10:22 INFO - ##### 02:10:22 INFO - ##### Running populate-webroot step. 02:10:22 INFO - ##### 02:10:22 INFO - Running pre-action listener: _resource_record_pre_action 02:10:22 INFO - Running main action method: populate_webroot 02:10:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:10:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:10:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:10:22 INFO - '--tppagecycles', 02:10:22 INFO - '7'], 02:10:22 INFO - 'tests': ['tsvgm']}}, 02:10:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:10:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:10:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:10:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:10:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:10:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:10:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:22 INFO - 'talos_options': ['--disable-e10s'], 02:10:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:22 INFO - 'talos_options': ['--disable-e10s'], 02:10:22 INFO - 'tests': ['damp', 'tps']}, 02:10:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:22 INFO - 'tests': ['damp', 'tps']}, 02:10:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:10:22 INFO - 'tests': ['dromaeo_dom']}, 02:10:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:10:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:10:22 INFO - 'tests': ['a11yr', 02:10:22 INFO - 'ts_paint', 02:10:22 INFO - 'tpaint', 02:10:22 INFO - 'sessionrestore', 02:10:22 INFO - 'sessionrestore_no_auto_restore', 02:10:22 INFO - 'tabpaint']}, 02:10:22 INFO - 'other-e10s': {'tests': ['a11yr', 02:10:22 INFO - 'ts_paint', 02:10:22 INFO - 'tpaint', 02:10:22 INFO - 'sessionrestore', 02:10:22 INFO - 'sessionrestore_no_auto_restore', 02:10:22 INFO - 'tabpaint']}, 02:10:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:10:22 INFO - 'ts_paint', 02:10:22 INFO - 'tpaint', 02:10:22 INFO - 'sessionrestore', 02:10:22 INFO - 'sessionrestore_no_auto_restore', 02:10:22 INFO - 'tabpaint']}, 02:10:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:10:22 INFO - 'ts_paint', 02:10:22 INFO - 'tpaint', 02:10:22 INFO - 'sessionrestore', 02:10:22 INFO - 'sessionrestore_no_auto_restore', 02:10:22 INFO - 'tabpaint']}, 02:10:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:10:22 INFO - 'tests': ['a11yr', 02:10:22 INFO - 'ts_paint', 02:10:22 INFO - 'tpaint', 02:10:22 INFO - 'sessionrestore', 02:10:22 INFO - 'sessionrestore_no_auto_restore', 02:10:22 INFO - 'tabpaint']}, 02:10:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:10:22 INFO - 'tests': ['a11yr', 02:10:22 INFO - 'ts_paint', 02:10:22 INFO - 'tpaint', 02:10:22 INFO - 'sessionrestore', 02:10:22 INFO - 'sessionrestore_no_auto_restore', 02:10:22 INFO - 'tabpaint']}, 02:10:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:10:22 INFO - 'tests': ['tsvgx', 02:10:22 INFO - 'tsvgr_opacity', 02:10:22 INFO - 'tart', 02:10:22 INFO - 'tscrollx', 02:10:22 INFO - 'cart']}, 02:10:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:10:22 INFO - 'tsvgr_opacity', 02:10:22 INFO - 'tart', 02:10:22 INFO - 'tscrollx', 02:10:22 INFO - 'cart']}, 02:10:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:22 INFO - 'talos_options': ['--disable-e10s'], 02:10:22 INFO - 'tests': ['tp5o']}, 02:10:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:22 INFO - 'tests': ['tp5o']}, 02:10:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:22 INFO - 'talos_options': ['--disable-e10s', 02:10:22 INFO - '--xperf_path', 02:10:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:22 INFO - 'tests': ['tp5n']}, 02:10:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:22 INFO - 'talos_options': ['--xperf_path', 02:10:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:22 INFO - 'tests': ['tp5n']}}, 02:10:22 INFO - 'talos.zip': {'path': '', 02:10:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:10:22 INFO - Running post-action listener: _resource_record_post_action 02:10:22 INFO - ##### 02:10:22 INFO - ##### Finished populate-webroot step (success) 02:10:22 INFO - ##### 02:10:22 INFO - ##### 02:10:22 INFO - ##### Running create-virtualenv step. 02:10:22 INFO - ##### 02:10:22 INFO - Running pre-action listener: _resource_record_pre_action 02:10:22 INFO - Running main action method: create_virtualenv 02:10:22 INFO - Creating virtualenv /builds/slave/test/build/venv 02:10:22 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 02:10:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:10:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:10:22 INFO - Using real prefix '/usr' 02:10:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:10:23 INFO - Installing distribute.............................................................................................................................................................................................done. 02:10:25 INFO - Installing pip.................done. 02:10:25 INFO - Return code: 0 02:10:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:25 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 0x7f03c386ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', '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 02:10:25 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 02:10:25 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 02:10:25 INFO - Using env: {'DISPLAY': ':0', 02:10:25 INFO - 'HOME': '/home/cltbld', 02:10:25 INFO - 'LANG': 'en_US.UTF-8', 02:10:25 INFO - 'LANGUAGE': 'en_US:en', 02:10:25 INFO - 'LOGNAME': 'cltbld', 02:10:25 INFO - 'MAIL': '/var/mail/cltbld', 02:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:25 INFO - 'MOZ_NO_REMOTE': '1', 02:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:25 INFO - 'NO_EM_RESTART': '1', 02:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:25 INFO - 'PWD': '/builds/slave/test', 02:10:25 INFO - 'SHELL': '/bin/bash', 02:10:25 INFO - 'SHLVL': '1', 02:10:25 INFO - 'TERM': 'linux', 02:10:25 INFO - 'TMOUT': '86400', 02:10:25 INFO - 'USER': 'cltbld', 02:10:25 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', 02:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:25 INFO - '_': '/tools/buildbot/bin/python'} 02:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:25 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 02:10:25 INFO - Cleaning up... 02:10:25 INFO - Return code: 0 02:10:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:25 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 0x7f03c386ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', '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 02:10:25 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 02:10:25 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 02:10:25 INFO - Using env: {'DISPLAY': ':0', 02:10:25 INFO - 'HOME': '/home/cltbld', 02:10:25 INFO - 'LANG': 'en_US.UTF-8', 02:10:25 INFO - 'LANGUAGE': 'en_US:en', 02:10:25 INFO - 'LOGNAME': 'cltbld', 02:10:25 INFO - 'MAIL': '/var/mail/cltbld', 02:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:25 INFO - 'MOZ_NO_REMOTE': '1', 02:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:25 INFO - 'NO_EM_RESTART': '1', 02:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:25 INFO - 'PWD': '/builds/slave/test', 02:10:25 INFO - 'SHELL': '/bin/bash', 02:10:25 INFO - 'SHLVL': '1', 02:10:25 INFO - 'TERM': 'linux', 02:10:25 INFO - 'TMOUT': '86400', 02:10:25 INFO - 'USER': 'cltbld', 02:10:25 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', 02:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:25 INFO - '_': '/tools/buildbot/bin/python'} 02:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:25 INFO - Downloading/unpacking psutil>=3.1.1 02:10:25 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 02:10:25 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 02:10:25 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 02:10:25 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 02:10:25 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 02:10:25 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 02:10:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:10:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:27 INFO - Installing collected packages: psutil 02:10:27 INFO - Running setup.py install for psutil 02:10:27 INFO - building 'psutil._psutil_linux' extension 02:10:27 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 02:10:28 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 02:10:28 INFO - building 'psutil._psutil_posix' extension 02:10:28 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 02:10:28 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 02:10:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:28 INFO - Successfully installed psutil 02:10:28 INFO - Cleaning up... 02:10:28 INFO - Return code: 0 02:10:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:10:28 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')]} 02:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:28 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')]} 02:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:28 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 0x7f03c386ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', '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 02:10:28 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 02:10:28 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 02:10:28 INFO - Using env: {'DISPLAY': ':0', 02:10:28 INFO - 'HOME': '/home/cltbld', 02:10:28 INFO - 'LANG': 'en_US.UTF-8', 02:10:28 INFO - 'LANGUAGE': 'en_US:en', 02:10:28 INFO - 'LOGNAME': 'cltbld', 02:10:28 INFO - 'MAIL': '/var/mail/cltbld', 02:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:28 INFO - 'MOZ_NO_REMOTE': '1', 02:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:28 INFO - 'NO_EM_RESTART': '1', 02:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:28 INFO - 'PWD': '/builds/slave/test', 02:10:28 INFO - 'SHELL': '/bin/bash', 02:10:28 INFO - 'SHLVL': '1', 02:10:28 INFO - 'TERM': 'linux', 02:10:28 INFO - 'TMOUT': '86400', 02:10:28 INFO - 'USER': 'cltbld', 02:10:28 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', 02:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:28 INFO - '_': '/tools/buildbot/bin/python'} 02:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:10:28 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 02:10:28 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 02:10:28 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 02:10:28 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 02:10:28 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 02:10:28 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 02:10:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:10:30 INFO - Installing collected packages: mozsystemmonitor 02:10:30 INFO - Running setup.py install for mozsystemmonitor 02:10:30 INFO - Successfully installed mozsystemmonitor 02:10:30 INFO - Cleaning up... 02:10:30 INFO - Return code: 0 02:10:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f03c386ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', '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 02:10:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:10:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:10:30 INFO - Using env: {'DISPLAY': ':0', 02:10:30 INFO - 'HOME': '/home/cltbld', 02:10:30 INFO - 'LANG': 'en_US.UTF-8', 02:10:30 INFO - 'LANGUAGE': 'en_US:en', 02:10:30 INFO - 'LOGNAME': 'cltbld', 02:10:30 INFO - 'MAIL': '/var/mail/cltbld', 02:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:30 INFO - 'MOZ_NO_REMOTE': '1', 02:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:30 INFO - 'NO_EM_RESTART': '1', 02:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:30 INFO - 'PWD': '/builds/slave/test', 02:10:30 INFO - 'SHELL': '/bin/bash', 02:10:30 INFO - 'SHLVL': '1', 02:10:30 INFO - 'TERM': 'linux', 02:10:30 INFO - 'TMOUT': '86400', 02:10:30 INFO - 'USER': 'cltbld', 02:10:30 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', 02:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:30 INFO - '_': '/tools/buildbot/bin/python'} 02:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:30 INFO - Downloading/unpacking jsonschema==2.5.1 02:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:10:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:32 INFO - Downloading functools32-3.2.3-2.tar.gz 02:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:10:32 INFO - warning: no files found matching '*.txt' 02:10:32 INFO - no previously-included directories found matching 'build' 02:10:32 INFO - no previously-included directories found matching 'dist' 02:10:32 INFO - no previously-included directories found matching '.git*' 02:10:32 INFO - Installing collected packages: jsonschema, functools32 02:10:33 INFO - Running setup.py install for functools32 02:10:33 INFO - warning: no files found matching '*.txt' 02:10:33 INFO - no previously-included directories found matching 'build' 02:10:33 INFO - no previously-included directories found matching 'dist' 02:10:33 INFO - no previously-included directories found matching '.git*' 02:10:33 INFO - Successfully installed jsonschema functools32 02:10:33 INFO - Cleaning up... 02:10:33 INFO - Return code: 0 02:10:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f03c386ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', '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 02:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:10:33 INFO - Using env: {'DISPLAY': ':0', 02:10:33 INFO - 'HOME': '/home/cltbld', 02:10:33 INFO - 'LANG': 'en_US.UTF-8', 02:10:33 INFO - 'LANGUAGE': 'en_US:en', 02:10:33 INFO - 'LOGNAME': 'cltbld', 02:10:33 INFO - 'MAIL': '/var/mail/cltbld', 02:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:33 INFO - 'MOZ_NO_REMOTE': '1', 02:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:33 INFO - 'NO_EM_RESTART': '1', 02:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:33 INFO - 'PWD': '/builds/slave/test', 02:10:33 INFO - 'SHELL': '/bin/bash', 02:10:33 INFO - 'SHLVL': '1', 02:10:33 INFO - 'TERM': 'linux', 02:10:33 INFO - 'TMOUT': '86400', 02:10:33 INFO - 'USER': 'cltbld', 02:10:33 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', 02:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:33 INFO - '_': '/tools/buildbot/bin/python'} 02:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:33 INFO - Downloading/unpacking blobuploader==1.2.4 02:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:35 INFO - Downloading blobuploader-1.2.4.tar.gz 02:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:10:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:10:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:35 INFO - Downloading docopt-0.6.1.tar.gz 02:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:10:36 INFO - Installing collected packages: blobuploader, requests, docopt 02:10:36 INFO - Running setup.py install for blobuploader 02:10:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:10:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:10:36 INFO - Running setup.py install for requests 02:10:36 INFO - Running setup.py install for docopt 02:10:36 INFO - Successfully installed blobuploader requests docopt 02:10:36 INFO - Cleaning up... 02:10:36 INFO - Return code: 0 02:10:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:36 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')]} 02:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:36 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')]} 02:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:36 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 0x7f03c386ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', '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 02:10:36 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 02:10:36 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 02:10:36 INFO - Using env: {'DISPLAY': ':0', 02:10:36 INFO - 'HOME': '/home/cltbld', 02:10:36 INFO - 'LANG': 'en_US.UTF-8', 02:10:36 INFO - 'LANGUAGE': 'en_US:en', 02:10:36 INFO - 'LOGNAME': 'cltbld', 02:10:36 INFO - 'MAIL': '/var/mail/cltbld', 02:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:36 INFO - 'MOZ_NO_REMOTE': '1', 02:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:36 INFO - 'NO_EM_RESTART': '1', 02:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:36 INFO - 'PWD': '/builds/slave/test', 02:10:36 INFO - 'SHELL': '/bin/bash', 02:10:36 INFO - 'SHLVL': '1', 02:10:36 INFO - 'TERM': 'linux', 02:10:36 INFO - 'TMOUT': '86400', 02:10:36 INFO - 'USER': 'cltbld', 02:10:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', 02:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:36 INFO - '_': '/tools/buildbot/bin/python'} 02:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:36 INFO - Running setup.py (path:/tmp/pip-Dx7Wih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:36 INFO - Running setup.py (path:/tmp/pip-uMPlQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:37 INFO - Running setup.py (path:/tmp/pip-MJy8HE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:37 INFO - Running setup.py (path:/tmp/pip-UIyUD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:37 INFO - Running setup.py (path:/tmp/pip-45z6fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:37 INFO - Running setup.py (path:/tmp/pip-GcxQsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:37 INFO - Running setup.py (path:/tmp/pip-Lloqt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:37 INFO - Running setup.py (path:/tmp/pip-fSMQ8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:37 INFO - Running setup.py (path:/tmp/pip-mgoKRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:37 INFO - Running setup.py (path:/tmp/pip-0zpO_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:37 INFO - Running setup.py (path:/tmp/pip-ajpUBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:37 INFO - Running setup.py (path:/tmp/pip-BAsHvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:37 INFO - Running setup.py (path:/tmp/pip-UC8INx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:37 INFO - Running setup.py (path:/tmp/pip-CW51T2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:37 INFO - Running setup.py (path:/tmp/pip-yHw92S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:37 INFO - Running setup.py (path:/tmp/pip-pydbQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:38 INFO - Running setup.py (path:/tmp/pip-kc2eYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:10:38 INFO - Running setup.py install for manifestparser 02:10:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Running setup.py install for mozcrash 02:10:38 INFO - Running setup.py install for mozdebug 02:10:38 INFO - Running setup.py install for mozdevice 02:10:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Running setup.py install for mozfile 02:10:38 INFO - Running setup.py install for mozhttpd 02:10:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Running setup.py install for mozinfo 02:10:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Running setup.py install for mozInstall 02:10:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:10:38 INFO - Running setup.py install for mozleak 02:10:39 INFO - Running setup.py install for mozlog 02:10:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:10:39 INFO - Running setup.py install for moznetwork 02:10:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:10:39 INFO - Running setup.py install for mozprocess 02:10:39 INFO - Running setup.py install for mozprofile 02:10:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:10:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:10:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:10:39 INFO - Running setup.py install for mozrunner 02:10:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:10:39 INFO - Running setup.py install for mozscreenshot 02:10:39 INFO - Running setup.py install for moztest 02:10:39 INFO - Running setup.py install for mozversion 02:10:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:10:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:10:39 INFO - Cleaning up... 02:10:39 INFO - Return code: 0 02:10:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:39 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')]} 02:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:39 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')]} 02:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:39 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 0x7f03c386ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', '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 02:10:39 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 02:10:39 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 02:10:39 INFO - Using env: {'DISPLAY': ':0', 02:10:39 INFO - 'HOME': '/home/cltbld', 02:10:39 INFO - 'LANG': 'en_US.UTF-8', 02:10:39 INFO - 'LANGUAGE': 'en_US:en', 02:10:39 INFO - 'LOGNAME': 'cltbld', 02:10:39 INFO - 'MAIL': '/var/mail/cltbld', 02:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:39 INFO - 'MOZ_NO_REMOTE': '1', 02:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:39 INFO - 'NO_EM_RESTART': '1', 02:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:39 INFO - 'PWD': '/builds/slave/test', 02:10:39 INFO - 'SHELL': '/bin/bash', 02:10:39 INFO - 'SHLVL': '1', 02:10:39 INFO - 'TERM': 'linux', 02:10:39 INFO - 'TMOUT': '86400', 02:10:39 INFO - 'USER': 'cltbld', 02:10:39 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', 02:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:39 INFO - '_': '/tools/buildbot/bin/python'} 02:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:40 INFO - Running setup.py (path:/tmp/pip-7zzKT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:40 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)) 02:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:40 INFO - Running setup.py (path:/tmp/pip-Ix1TAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:40 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)) 02:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:40 INFO - Running setup.py (path:/tmp/pip-J23iRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:40 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)) 02:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:40 INFO - Running setup.py (path:/tmp/pip-cqnotr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:40 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)) 02:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:40 INFO - Running setup.py (path:/tmp/pip-O1Tkot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:40 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)) 02:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:40 INFO - Running setup.py (path:/tmp/pip-8p176S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:40 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)) 02:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:40 INFO - Running setup.py (path:/tmp/pip-1qTKab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:40 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)) 02:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:40 INFO - Running setup.py (path:/tmp/pip-AjAvoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:40 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)) 02:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:40 INFO - Running setup.py (path:/tmp/pip-LjJCwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:40 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)) 02:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:40 INFO - Running setup.py (path:/tmp/pip-uvuKQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:40 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)) 02:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:40 INFO - Running setup.py (path:/tmp/pip-R2kdLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:40 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)) 02:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:40 INFO - Running setup.py (path:/tmp/pip-iiqrOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:41 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)) 02:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:41 INFO - Running setup.py (path:/tmp/pip-9Fy8aA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:41 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)) 02:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:41 INFO - Running setup.py (path:/tmp/pip-cew_On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:41 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)) 02:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:41 INFO - Running setup.py (path:/tmp/pip-_Mzr2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:41 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)) 02:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:41 INFO - Running setup.py (path:/tmp/pip-3oqpMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:41 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)) 02:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:41 INFO - Running setup.py (path:/tmp/pip-mq2pTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:41 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)) 02:10:41 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)) 02:10:41 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)) 02:10:41 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)) 02:10:41 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)) 02:10:41 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)) 02:10:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:10:41 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 02:10:41 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 02:10:41 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 02:10:41 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 02:10:41 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 02:10:41 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 02:10:43 INFO - Downloading blessings-1.6.tar.gz 02:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:10:43 INFO - Installing collected packages: blessings 02:10:43 INFO - Running setup.py install for blessings 02:10:43 INFO - Successfully installed blessings 02:10:43 INFO - Cleaning up... 02:10:43 INFO - Return code: 0 02:10:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:43 INFO - Reading from file tmpfile_stdout 02:10:43 INFO - Current package versions: 02:10:43 INFO - argparse == 1.2.1 02:10:43 INFO - blessings == 1.6 02:10:43 INFO - blobuploader == 1.2.4 02:10:43 INFO - docopt == 0.6.1 02:10:43 INFO - functools32 == 3.2.3-2 02:10:43 INFO - jsonschema == 2.5.1 02:10:43 INFO - manifestparser == 1.1 02:10:43 INFO - mozInstall == 1.12 02:10:43 INFO - mozcrash == 0.17 02:10:43 INFO - mozdebug == 0.1 02:10:43 INFO - mozdevice == 0.48 02:10:43 INFO - mozfile == 1.2 02:10:43 INFO - mozhttpd == 0.7 02:10:43 INFO - mozinfo == 0.9 02:10:43 INFO - mozleak == 0.1 02:10:43 INFO - mozlog == 3.2 02:10:43 INFO - moznetwork == 0.27 02:10:43 INFO - mozprocess == 0.22 02:10:43 INFO - mozprofile == 0.28 02:10:43 INFO - mozrunner == 6.11 02:10:43 INFO - mozscreenshot == 0.1 02:10:43 INFO - mozsystemmonitor == 0.3 02:10:43 INFO - moztest == 0.7 02:10:43 INFO - mozversion == 1.4 02:10:43 INFO - psutil == 3.1.1 02:10:43 INFO - requests == 1.2.3 02:10:43 INFO - wsgiref == 0.1.2 02:10:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f03c386ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', '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 02:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:10:43 INFO - Using env: {'DISPLAY': ':0', 02:10:43 INFO - 'HOME': '/home/cltbld', 02:10:43 INFO - 'LANG': 'en_US.UTF-8', 02:10:43 INFO - 'LANGUAGE': 'en_US:en', 02:10:43 INFO - 'LOGNAME': 'cltbld', 02:10:43 INFO - 'MAIL': '/var/mail/cltbld', 02:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:43 INFO - 'MOZ_NO_REMOTE': '1', 02:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:43 INFO - 'NO_EM_RESTART': '1', 02:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:43 INFO - 'PWD': '/builds/slave/test', 02:10:43 INFO - 'SHELL': '/bin/bash', 02:10:43 INFO - 'SHLVL': '1', 02:10:43 INFO - 'TERM': 'linux', 02:10:43 INFO - 'TMOUT': '86400', 02:10:43 INFO - 'USER': 'cltbld', 02:10:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', 02:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:43 INFO - '_': '/tools/buildbot/bin/python'} 02:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:10:43 INFO - Cleaning up... 02:10:43 INFO - Return code: 0 02:10:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f03c386ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', '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 02:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:10:43 INFO - Using env: {'DISPLAY': ':0', 02:10:43 INFO - 'HOME': '/home/cltbld', 02:10:43 INFO - 'LANG': 'en_US.UTF-8', 02:10:43 INFO - 'LANGUAGE': 'en_US:en', 02:10:43 INFO - 'LOGNAME': 'cltbld', 02:10:43 INFO - 'MAIL': '/var/mail/cltbld', 02:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:43 INFO - 'MOZ_NO_REMOTE': '1', 02:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:43 INFO - 'NO_EM_RESTART': '1', 02:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:43 INFO - 'PWD': '/builds/slave/test', 02:10:43 INFO - 'SHELL': '/bin/bash', 02:10:43 INFO - 'SHLVL': '1', 02:10:43 INFO - 'TERM': 'linux', 02:10:43 INFO - 'TMOUT': '86400', 02:10:43 INFO - 'USER': 'cltbld', 02:10:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', 02:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:43 INFO - '_': '/tools/buildbot/bin/python'} 02:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:10:44 INFO - Cleaning up... 02:10:44 INFO - Return code: 0 02:10:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f03c386ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', '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 02:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:10:44 INFO - Using env: {'DISPLAY': ':0', 02:10:44 INFO - 'HOME': '/home/cltbld', 02:10:44 INFO - 'LANG': 'en_US.UTF-8', 02:10:44 INFO - 'LANGUAGE': 'en_US:en', 02:10:44 INFO - 'LOGNAME': 'cltbld', 02:10:44 INFO - 'MAIL': '/var/mail/cltbld', 02:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:44 INFO - 'MOZ_NO_REMOTE': '1', 02:10:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:44 INFO - 'NO_EM_RESTART': '1', 02:10:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:44 INFO - 'PWD': '/builds/slave/test', 02:10:44 INFO - 'SHELL': '/bin/bash', 02:10:44 INFO - 'SHLVL': '1', 02:10:44 INFO - 'TERM': 'linux', 02:10:44 INFO - 'TMOUT': '86400', 02:10:44 INFO - 'USER': 'cltbld', 02:10:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', 02:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:44 INFO - '_': '/tools/buildbot/bin/python'} 02:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:44 INFO - Downloading/unpacking flake8 02:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:10:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:10:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:10:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:10:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:10:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:10:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:10:46 INFO - no previously-included directories found matching 'docs/_build' 02:10:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:10:47 INFO - Running setup.py install for pep8 02:10:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:10:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:10:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:10:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:10:47 INFO - no previously-included directories found matching 'docs/_build' 02:10:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:10:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:10:47 INFO - Cleaning up... 02:10:47 INFO - Return code: 0 02:10:47 INFO - Running post-action listener: _resource_record_post_action 02:10:47 INFO - Running post-action listener: _start_resource_monitoring 02:10:47 INFO - Starting resource monitoring. 02:10:47 INFO - ##### 02:10:47 INFO - ##### Finished create-virtualenv step (success) 02:10:47 INFO - ##### 02:10:47 INFO - ##### 02:10:47 INFO - ##### Running install step. 02:10:47 INFO - ##### 02:10:47 INFO - Running pre-action listener: _resource_record_pre_action 02:10:47 INFO - Running main action method: install 02:10:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:47 INFO - Reading from file tmpfile_stdout 02:10:47 INFO - Detecting whether we're running mozinstall >=1.0... 02:10:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:10:47 INFO - Reading from file tmpfile_stdout 02:10:47 INFO - Output received: 02:10:47 INFO - Usage: mozinstall [options] installer 02:10:47 INFO - Options: 02:10:47 INFO - -h, --help show this help message and exit 02:10:47 INFO - -d DEST, --destination=DEST 02:10:47 INFO - Directory to install application into. [default: 02:10:47 INFO - "/builds/slave/test"] 02:10:47 INFO - --app=APP Application being installed. [default: firefox] 02:10:47 INFO - mkdir: /builds/slave/test/build/application 02:10:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:11:04 INFO - Reading from file tmpfile_stdout 02:11:04 INFO - Output received: 02:11:04 INFO - /builds/slave/test/build/application/firefox/firefox 02:11:04 INFO - Running post-action listener: _resource_record_post_action 02:11:04 INFO - ##### 02:11:04 INFO - ##### Finished install step (success) 02:11:04 INFO - ##### 02:11:04 INFO - ##### 02:11:04 INFO - ##### Running run-tests step. 02:11:04 INFO - ##### 02:11:04 INFO - Running pre-action listener: _resource_record_pre_action 02:11:04 INFO - Running main action method: run_tests 02:11:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:11:04 INFO - Python 2.7.3 02:11:04 INFO - Return code: 0 02:11:04 INFO - grabbing minidump binary from tooltool 02:11:04 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')]} 02:11:04 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 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:11:04 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 02:11:04 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 02:11:04 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 02:11:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:11:04 INFO - Return code: 0 02:11:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:11:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:11:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:11:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:11:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:11:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:11:05 INFO - Return code: 0 02:11:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 02:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 02:11:05 INFO - Using env: {'DISPLAY': ':0', 02:11:05 INFO - 'HOME': '/home/cltbld', 02:11:05 INFO - 'LANG': 'en_US.UTF-8', 02:11:05 INFO - 'LANGUAGE': 'en_US:en', 02:11:05 INFO - 'LOGNAME': 'cltbld', 02:11:05 INFO - 'MAIL': '/var/mail/cltbld', 02:11:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:11:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:05 INFO - 'MOZ_NO_REMOTE': '1', 02:11:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:05 INFO - 'NO_EM_RESTART': '1', 02:11:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:05 INFO - 'PWD': '/builds/slave/test', 02:11:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:11:05 INFO - 'SHELL': '/bin/bash', 02:11:05 INFO - 'SHLVL': '1', 02:11:05 INFO - 'TERM': 'linux', 02:11:05 INFO - 'TMOUT': '86400', 02:11:05 INFO - 'USER': 'cltbld', 02:11:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819', 02:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:05 INFO - '_': '/tools/buildbot/bin/python'} 02:11:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 02:11:05 INFO - mozversion application_buildid: 20160608233033 02:11:05 INFO - mozversion application_changeset: f8bdceb55c9d191380176ab25e2385737bd9e1ab 02:11:05 INFO - mozversion application_display_name: Nightly 02:11:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:11:05 INFO - mozversion application_name: Firefox 02:11:05 INFO - mozversion application_remotingname: firefox 02:11:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:11:05 INFO - mozversion application_vendor: Mozilla 02:11:05 INFO - mozversion application_version: 50.0a1 02:11:05 INFO - mozversion platform_buildid: 20160608233033 02:11:05 INFO - mozversion platform_changeset: f8bdceb55c9d191380176ab25e2385737bd9e1ab 02:11:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:11:05 INFO - mozversion platform_version: 50.0a1 02:11:05 INFO - using testdate: 1465463465 02:11:05 INFO - actual date: 1465463465 02:11:05 INFO - starting webserver on 'localhost:44984' 02:11:05 INFO - SUITE-START | Running 2 tests 02:11:05 INFO - TEST-START | dromaeo_css 02:11:05 INFO - operating with platform_type : linux_ 02:11:05 INFO - Initialising browser for dromaeo_css test... 02:11:05 INFO - TEST-INFO | started process 5581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp85wb9m/profile http://localhost:44984/getInfo.html) 02:11:10 INFO - PROCESS | 5581 | __metrics Screen width/height:1600/1200 02:11:10 INFO - PROCESS | 5581 | colorDepth:24 02:11:10 INFO - PROCESS | 5581 | Browser inner width/height: 1024/697 02:11:10 INFO - PROCESS | 5581 | __metrics 02:11:11 ERROR - PROCESS | 5581 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 02:11:11 INFO - TEST-INFO | 5581: exit 0 02:11:11 INFO - Browser initialized. 02:11:11 INFO - Running cycle 1/1 for dromaeo_css test... 02:11:11 INFO - TEST-INFO | started process 5701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp85wb9m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:11:23 INFO - PROCESS | 5701 | RSS: Main: 167890944 02:11:23 INFO - PROCESS | 5701 | 02:12:13 INFO - PROCESS | 5701 | 1465463533367 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] 02:14:21 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:44984/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44984/tests/dromaeo/cssquery-ext.html) 02:14:23 INFO - PROCESS | 5701 | RSS: Main: 171499520 02:14:23 INFO - PROCESS | 5701 | 02:17:25 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:44984/tests/dromaeo/cssquery-ext.html (next: http://localhost:44984/tests/dromaeo/cssquery-jquery.html) 02:17:25 INFO - PROCESS | 5701 | RSS: Main: 170389504 02:17:25 INFO - PROCESS | 5701 | 02:20:27 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:44984/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44984/tests/dromaeo/cssquery-mootools.html) 02:20:28 INFO - PROCESS | 5701 | RSS: Main: 171667456 02:20:28 INFO - PROCESS | 5701 | 02:23:30 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:44984/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44984/tests/dromaeo/cssquery-prototype.html) 02:23:30 INFO - PROCESS | 5701 | RSS: Main: 169435136 02:23:30 INFO - PROCESS | 5701 | 02:26:33 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:44984/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44984/tests/dromaeo/cssquery-yui.html) 02:26:33 INFO - PROCESS | 5701 | RSS: Main: 171548672 02:26:33 INFO - PROCESS | 5701 | 02:29:36 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:44984/tests/dromaeo/cssquery-yui.html (next: http://localhost:44984/tests/dromaeo/cssquery-dojo.html) 02:29:36 INFO - PROCESS | 5701 | RSS: Main: 172347392 02:29:36 INFO - PROCESS | 5701 | 02:29:36 INFO - PROCESS | 5701 | __start_tp_report 02:29:36 INFO - PROCESS | 5701 | _x_x_mozilla_page_load 02:29:36 INFO - PROCESS | 5701 | _x_x_mozilla_page_load_details 02:29:36 INFO - PROCESS | 5701 | |i|pagename|runs| 02:29:36 INFO - PROCESS | 5701 | |0;dojo.html;3186.7450603951684;3242.4974129009997;3250.2849373137915;3278.7213086887614;3294.308195278991;5501.807436739715;5511.173324001402;5529.142982837661;5562.527185189264;5568.136938774496;5424.701641409721;5575;5597.692126933017;5604.8038318658855;5634.32388113427;5008.098542262392;5039.420466646346;5128.948710512903;5156.896862062757;5164.406093299281;5047.621428392867;5205.9219111713355;5238.60710446718;5250.18622113573;5254.7635356409055;4988.650794444408;4996.325496058022;5037.244413337992;5082.847514574569;5092.363454568179;5046.7224302663335;5056;5056.84829455117;5066.530706095228;5111.539961403454;5004.299398084271;5033.0688822567945;5039.193729003342;5042.647014708972;5080.466551012128;5473.8357849264585;5495.093309603911;5510.586705997066;5524.889502209933;5555.444455554452;6013.067974463965;6026.758929642809;6045.909311360333;6047.425494578008;6053.909191362133;5820.388859169769;5870.97064514679;5956.434138756811;6018.6990650467305;6035.366286539894;5552.361478429992;5567.805126820583;5650.576206784466;5651.547876169938;5690.061139911951;6178;6183.258009038944;6204.100405441186;6204.255489341308;6222.62664240147;5742.052561327418;5953.1070339449425;5959.910601340984;5960.195373624592;5968.761249550056;5886.05823068307;5935.376785437467;5991.131285963511;5991.400859914061;6026;5802.33273173582;5854.677992710356;5924.763009479572;5985.850353741104;6013.54898382623;5916.112583112482;5962.433568810956;5962.731677074542;5963.105534169909;5964.105384192406;4437.467503899553;4468.03937153507;4476.574725401082;4487.237169681162;4505.526919673387;3991.1618560102124;4005.239004589119;4010.939835902464;4035.29382358092;4049.2913740095364;5483.643563168382;5591.580631452657;5612.326520817528;5641.182028605829;5652.717364131777;5916.5858389913155;5942.168096466498;5956.136360227742;5967.492763115184;5991.700414979234;5591.916121258185;5602.97198514013;5641.26663533738;5657.830265091971;5668.206451096849;5018.272350509155;5111.412187598474;5113.080623590223;5119.462456442095;5124.769385377667;6096.420840020191;6155;6189.721462534197;6205.937940620626;6240.157578726905;5982.1325907744;5995.220621319288;5996.040633498619;6049.4447790315535;6055.9091613626715;5969.492593129633;6079.513638908788;6086.969565152146;6162.599431036968;6176.289726681489;5920.79277225295;5926.140709597171;5926.318473375617;5937.139114828412;5984;5937.495312898452;5955.285365756137;6003.129546215861;6008.279006519246;6019.969900150471;5713.7428815704225;5729.885402292014;5817.040188368872;5830.329512106162;5854.180414742024;5658.066419040977;5674.120511320752;5698.886022279614;5783.913241301468;5788;5641.069223578063;5684.033714268667;5718.79984200551;5719.3136823581435;5719.742611582572;5785.566082543742;5819.592628515963;5857.677827719516;5886.293644762484;5954.225950626391;5625.071863142535;5628.577856660685;5747.511461525817;5755.8561035974435;5774.162746401664 02:29:36 INFO - PROCESS | 5701 | |1;ext.html;571.8084441712026;618.3723520626563;623.1836294454263;639.8144538083955;644.8162273751982;37796.43305350422;42510.7874460628;42628.57371426285;42758.572414275885;42971.570284297144;42695.78652106735;42939;42999.3550096748;43025.35461968073;43041.56958430415;8654.09132041136;8762.474251544896;8768.035516093225;8769.736907892742;8788.69239576615;8696.608652610648;8716.041235464094;8753.824923501526;8754.474731516098;8755.343349248831;8776.07851175627;8787;8791.340649451286;8812.779680507974;8824.735257942271;8640.524771137585;8652.04827468978;8664.350173736995;8722.607482663296;8751.606177722018;8632.741017769415;8635.611397487128;8676.696315628986;8693.782655433664;8701;40800.59199407998;41225;41280.79359603183;41296.58703412987;41395;3476.0222059868825;3600.1539638185004;3616.9095772605897;3680.1719613087107;3704.592494825567;32197.235711617483;32528.349433011208;32721;32882;33627.327453450795;4346.587074227943;4360.7819609019425;4398.670099742532;4403.867883963486;4489.057297967431;354590;354921;355184;355921;356810;33292.83353583265;34100.658993410245;57525;58052.12921806176;58071;36543.4518482223;36620.084497887234;36628.267434651156;36664.45003324952;36710.449343259876;15378;15516.224188790515;15531.689366212613;15590.220488975507;15617.3753049879;12868.935655321664;12991.480340786262;13046.47814087445;13065.673358166121;13109.606711798471;8290.046644635824;8304.543250121302;8386.035605905277;8388.412811103286;8429.283510901641;3285.704286614216;3287.4247006773717;3316.7844090134063;3317.0712200583876;3337.9666203338143;1044.7335929337971;1079.6167360586878;1100.4717735486852;1100.4882729530646;1172.648205538335;30676;32269.35461290761;32617.51073733896;32647.673523264937;33010;1159.9942000290114;1175.9118066145074;1219;1222.6882145052955;1272.6563827766636;16779.412720554723;17064.146792660318;17291.308347665952;17292.308307667805;17496.387626433014;607647;608437;612285;617337;617446;57778;58173.709131454074;58498.41501585015;58613;58674.70662646745;1342.7918672605763;1385.743637427059;1388.6181300142541;1397.6575738944023;1403.305363844883;29252.268693282836;30319.848400757855;30506.694933050385;30726.539101913935;31045.379092418476;51557.48442515527;51610.22584661308;51952;52075.739621301655;52220;483116;485244;487126;488275;489079;27790;27931.16206513808;28213.717862821108;28421.857890710413;28570;47359;48125.51874481211;48499.27251091307;48539;48816.755916220194;40606.736292690024;41698;41706.37440438335;41955.58044419517;42704.35943460788;40960.38559421551;41710.791446042575;41817;42117.1576568473;42202;34063.829680851435;34663.826680866434;35213.29573408569;35573.644263557035;40296.597034030456;35378.58485660545;37229;37660.62339376571;37743.62256377401;37827.24345513129;27800.721992779814;28646.85676571604;28843.5673464894;28849.855750721952;29008.564871527367 02:29:36 INFO - PROCESS | 5701 | |2;jquery.html;388.2952441319004;391.3308242904633;393.99212015759684;397.85279446604756;415.94176815245874;14250;15448.304826282816;18382.356617518373;19727.80272197276;19857.60284794303;15689.764653530206;17905.82094179058;18720.719189212137;18749.96875171865;18753.531161720963;5261.079311120558;5304.761285742132;5781.364049954502;5900.822975310747;5947.1971283876555;5789.855253618651;5810;5827.650340979533;5840.415958404168;5840.941590584082;5265.842024739245;5339.199120131992;5359.517643412092;5380.139177731564;5680.233168522238;5296.25852380667;5371.328583927009;5396.622236443451;5421.864453388657;5423.674579525202;5009.323741294915;5288.497592728685;5300.469953004668;5373.838784836461;5403.729813509348;13705.177689338572;13906.58280251594;14056.648583785487;19201.519962000923;22291.219807306665;2226;2512.944563283407;2588.8187826852127;2919.7080291970633;2922.8684709188137;9912.504374781303;10079.848802267972;10107.89892101077;10272.435016074112;10357.171426285879;1852.2220667319757;1927.9807201927943;1952.4142757172792;1952.726618273443;1967.0754745269844;80918.59540702259;81528.18471815325;82286.17713822845;82866.17133828584;84529;11078.335299882034;11112.499937502831;11295.830562541569;11313.321200727984;11346.659600212008;15398.846011539741;15406.460773872861;15451.845481545266;15662.138582378078;15679.451219207273;7206.207317195104;7350.926490735131;8125.75622731319;8299.336053115736;8623;7346.485745997729;7438.181800001996;7737;7841.451098423056;7848.529088254609;4726.338312636233;4769.260764581495;4827.348307978378;4875.585575226075;4889.828855990023;1951.3853136262032;1980.8613397062356;1994.4814348269554;2005.7994200580117;2019.4042757386605;948.3693343926212;1015.0712098429854;1016.1667432705111;1024.6516184497307;1046.8115739167024;19075.809899687727;19368.322108726126;19541.706874396896;19543.902280488506;19615.31346402869;936.8454205056225;983.5229913491951;1022.8516865054675;1059.7615536504225;1060.4909643371225;10399.428031458343;10833.349999000086;10917.945410272898;10919.617813376653;10969.83545246822;513142;513793.2931006038;517194;519055;520037;96969.51515242379;98805;99086.50456747814;100178.49910750546;100384;1008.742770593494;1026.0970346095537;1052.7947050325113;1079.1636481726725;1079.4171147580375;16590.917045414695;16594.419195328104;16670.16649167561;16696.248668810174;16905.74641380405;39264.803675981435;41137.58862411338;41942.16115677731;42273;43933.121337573706;48404.27393589028;58763.412365877506;59750;60418.697906510184;60587.09119363125;8413.3269338454;8520.957395212985;8643;8680.088590697886;8712.651493940171;9305.813883722152;13162.14446061003;13435.462581496631;13460.125091868997;13475.932620336836;10992.230543861853;11242.156838237328;11393.658190254306;11631.302121872715;12231;11621.6513504595;11722.120840937134;11725.824112638147;11900.464479098287;11997.520099196283;11829.704257393634;11908.76182476363;12092.15354925182;12144.514219431123;12283.57007504733;8709.259712924473;8855.557222138996;8909.933807670222;9069.682561110329;9091.09089091112;9082.137196966278;11009.394483303495;11266.04238639692;12189.817152742538;12192.939035304767 02:29:36 INFO - PROCESS | 5701 | |3;mootools.html;1480.792689023537;1504.1877386211447;1601.6796640671869;1738.9565260868476;1753;7610.619469026554;8189.549574773385;8271.793205169874;8868.55657217139;8877.112288771128;8242.546659933701;8457.407981441285;8468.280196183332;8544.444611100289;8561.785955351104;2258.695076164717;2319.130326127702;2322.814174866015;2329.522447898177;2332.6617640442128;2279.4073540879326;2311.503026849227;2330.5571941331177;2343.3321503371544;2349.823763217757;2326.8952897119584;2332.5101728636923;2333.88330583471;2349.6475528670667;2353.51752890657;2284.9543009139725;2287.0623044551653;2298.276043046443;2320.0487800002;2339.356676913845;2289.713785776778;2306.5156317173414;2309.7690230976937;2315.6758053872472;2321.1875843454654;8452.323814094858;8517.957410212972;8527.616257268437;8529.57352132391;8531.360147988926;5128.25640282157;5211.114110601169;5238.397584277781;5245.501677340647;5250;3272.689094536015;3383.4079036168573;3456.4469684850555;3471.444568868994;3480.3387356402454;1134.6142311614008;1162.3665102519146;1168.1589255735857;1172.5192671004932;1186.857577090746;12335.198212116273;12356;12361;12368.567100151542;12468.127231093828;4549.567791059844;4590.816367345269;4659.930101048487;4697.318888761179;4715.033418149271;10376.533056012497;10405.27163098591;10405.84391234132;10408.219383546264;10420;5155.200943853709;5155.355580552431;5211.635185536976;5295.073362161606;5308.893822123536;4177.540470548237;4618.953810461852;4792.496787837227;4806.759662016955;4862.586680132157;3903.5510916244993;3910.843566257318;3991.2416640838146;3999.8200080996426;4040.777757223322;1211.3458732284644;1214.8117041858527;1220.5666988219054;1229.9200551964093;1238.1642391385778;1012.0840639221516;1032.9793404131876;1033.1476531861244;1033.834586466162;1035.5133087448887;5868.765249390062;6035.124906888476;6037.335893051761;6210.9068363974575;6235.96882015587;471.51905056842514;477.47000829079695;478.5788506114597;480.70917095157625;486.0716032378141;4180.686448516373;4184.3932629768515;4191.497020357577;4213.262679031157;4233.322668373045;10767.676969690921;11011.61459348919;11073.667789966154;11120.721981950353;11165.106791456665;10753.354798712102;10919.235653504178;10976.5181700471;11028.338299702044;11066.170037247239;7745.496542724705;8044.798880028046;8079.636416361278;8239.958800206081;8254.54599996994;5871.295444546682;6069.575129740876;6122.6938653068055;6163.84590385244;6219.533534984804;9940.204783617437;10142.340747851365;10261.897381026392;10284.537195826355;10345.63790267337;10263.332883362558;10462.58149674035;10509.31689440184;10573;10584.629537966135;7105.360517553238;7506.474546781891;7672.156062832973;7754.961225193838;7780.610969451618;8534.573271336532;8559.315254779478;8571.785705357415;8606.827863442571;8626.18051285127;7507.549547026977;7790;7791.259830316111;7840.176781437867;7851.607419628882;7515.060617422822;7525.73659921922;7528.209537998431;7570.962145189239;7771.184025677222;6575.4410875076155;6596.142501474777;6618.172728408949;6675.933240667531;6678.432333251728;4946.985867897;5031.094403007493;5046.167382382013;5152;5236.423993360651;5148.253503242084;5154.098032844162;5170.224466330081;5253.71104589236;5290.470952904679 02:29:36 INFO - PROCESS | 5701 | |4;prototype.html;334.11126403765985;334.81919763327807;338.3773856104768;338.9237421580143;341.2407393549353;5585.385607583167;5688.317401911771;5690.2887139107615;5707.800226992056;5737.168110623957;5549.0289199390145;5570.025245582017;5570.637908535942;5582;5641.407652196522;4151.750894946305;4270.295401258804;4304.913901721964;4360.542143074979;4368.060866913613;4346.97826510867;4383.846565370212;4403.339499075132;4411.514733379326;4430.759387371541;4379.4963579188325;4384;4393.692441529094;4399.626031787302;4406.5373135820755;4264.763218666599;4318.762468064271;4319.157764235975;4367.301231802928;4374.781260936972;3839.731218814684;3847.76913385195;3863.150106976461;3875.9418608720894;3893.5717071122153;5411.269478620376;5413.052715774724;5444.727763611803;5448.618596698233;5470.699111548864;4855.620745834551;5010.323606313137;5026.29631851541;5042.773075211624;5043.470435604282;5812.970935145339;5884.323302820188;5887.764489420418;5906.704664766745;5947.583669143161;4247.723897946624;4251;4257.489101307832;4259.74441533509;4263.126059157865;5963.970180149072;6057.485113765291;6086.665233412161;6136.110264011738;6142.232220972379;4371.693981421334;4372.912541749147;4379.5255680540395;4380.145871555016;4385.956140438555;4404.515503294635;4435.578620031092;4437.334399839985;4454.354118652842;4460.442444694413;4702.858914232578;4943.184374578226;4957.553820156203;4971.353724015855;5065.265536497187;5938.851528711817;5958.910616340759;5978.133170690226;5980.55145864062;6000.22993217002;1468.875145612635;1489.4265707702396;1494.4470545898087;1497.8352381238055;1502.5267040882088;961.7497253570331;986.7335819328741;998.9710598083985;1002.468691593442;1012.2661070723814;5536.169574563848;5546.55627549795;5590.18942253371;5609.859753506195;5641.830745077655;5947.524198064145;5969.641821490724;6004.3395226525045;6032.758689652364;6033.315174747283;5467.644603100785;5565.638233514808;5704.458076482728;5763.106718458645;5764.7117644117625;3215.2926356201597;3228.7094161525574;3256.7135981287734;3275.623303320149;3283.228441316289;6222.439980401695;6308.400701933309;6337.9366206337345;6338.651374174465;6365.472286651263;6211.9129152398145;6234.719437625317;6248.343923888017;6254.312025677172;6272.498200143978;6111.297200821962;6289.371062893765;6356.872862542816;6394.840128996812;6421.325760795143;6093.720318733116;6124;6127.8468038297615;6136.601120927304;6175.475084617858;6034.185384972972;6104.80227118246;6139.201903752483;6139.219626308321;6170.3212646607935;6111.724972376165;6235.064740288812;6376.681165941592;6402.35976402356;6426.132472116205;4267;4268.423762791983;4287.485501739687;4307.310830267143;4310.568943105664;5902.498287645598;6170.994426811215;6172.506199504119;6240.563160578716;6277.937220627918;6020.638761674313;6032.849178770566;6053.818385448443;6064.301995441284;6066;5978.252718410199;6038;6043.697815109139;6043.879122417439;6058.303295121117;5549.861253468534;5842.211301474246;5847.970760146172;5855.238818953509;5902.61632993854;5886.499647530008;5957.52762603532;5966.522678185648;6002.399760024137;6012.428819262163;5659.754853932129;5848.385919478564;5865.296164460292;5937.643741375531;5944.554158438221 02:29:36 INFO - PROCESS | 5701 | |5;yui.html;744.743063643043;750.455919458393;790.4545863354285;816.9305609023232;829.842329957308;14836.961412701115;15474.845251547482;15942;15997.360105595792;16017.839821601781;14746.852531474682;14778.482753103644;15108;15585.84414155858;15653.686926261496;810.2140923304386;812.46377390922;815.3843847894831;816.0533780814256;816.4529765057396;786.5713186313444;802.1657476224719;803.7869964459423;828.5857071464268;830.6179157587517;844.7001314533344;851.4550687559966;852.722865068852;855.5764896376271;857.0615176381851;840.9032961209417;853.2022558907441;853.7865533616596;854.2567965869733;855.448235887852;619.4734475695668;620.8727210921795;623.5198896849446;623.9532035097386;625.6715224507125;15592;15692.293846776809;15700;15703.371865125382;15717.607059823482;14730.410783568645;14809;14897.553073407815;15022.774658380133;15082.849171508255;12276.938615306866;12350;12464.43910024042;12544.498220071186;12802.103852730312;3559.9110022249392;3606.729495287838;3683.723720720957;3755.7746535207975;3771.547414310273;78548.60725696335;78797.21202787956;79851.20148798496;80124.59937700274;80335.5983220086;10783.946080269548;11102.833457498144;11339.376334301527;11554.191206615624;11560.826587601192;21276.680849787266;21462.678059828802;21651.891740541512;21656.242031529135;21696.89151554232;8368.20502052304;8638.956805215934;8851.982022067416;8983.236424903826;9206.585703643352;4674.158651442705;4907.509249075064;5024.095662780662;5026.74866256693;5037.546620804145;3645.398509245998;3774.452704357853;3793.9241215176094;3795.316842968237;3813.84744610218;619.1115748900343;631.4348657951108;638.1831255992245;638.3871483375918;641.8940874755706;656.743869890743;743.4721347842984;749.9250074992566;770.76106407014;775.4688038693513;9535.332526723201;9874.96695875951;10080.848787268196;10091.899081009244;10627.628033018807;667.9933200667931;773.860705073081;774.9573773442402;779.8245394786128;800.7757827808223;4651.534846515389;4700.224462963641;4846.975765121152;4934.383202099738;5147.794088236428;109757.86573872673;110708;115989;119673;119685.40157299332;100307.49846250722;101350;101981;102234;102673;84745.57627211824;85334.5733271342;87813.56093219621;88460;89720.10279897117;9420.858687119562;9452.149306562442;9503.61985520599;9576.715359014572;9580.520973951136;52835.94328113339;52925.20612190743;53475.73262133665;54178;54282.185767214316;67908;68795.31204688089;74118.62940685477;75886.62056689902;76539.61730191314;12076.45655945467;12231.633051008484;12261.26432414058;12623.431945562288;12729.981601472045;13627.058876265977;13714.314284285547;13992.580222593338;14172.787408189091;14452.421903123757;11802.52789888395;11813.76372472563;11992.620848602173;12127.636170914886;12512.124151309685;12944.611661650166;13237.27195004284;13249;13285.468581256642;13370.398332074885;12141.878581214074;12392.504299827906;12487.063470239587;12517.123801333819;13007.674808129872;10558.155347572023;10743.892232274371;10772.784544308914;10788.838167427339;11208.65152583452;10974.231803773979;11058.336499810037;11064.336139831636;11096.278741881752;11103.72240693989 02:29:36 INFO - PROCESS | 5701 | __end_tp_report 02:29:36 INFO - PROCESS | 5701 | __start_cc_report 02:29:36 INFO - PROCESS | 5701 | _x_x_mozilla_cycle_collect,363 02:29:36 INFO - PROCESS | 5701 | __end_cc_report 02:29:36 INFO - PROCESS | 5701 | __startTimestamp1465464576681__endTimestamp 02:29:36 INFO - PROCESS | 5701 | 02:29:36 INFO - PROCESS | 5701 | ------- Summary: start ------- 02:29:36 INFO - PROCESS | 5701 | Number of tests: 6 02:29:36 INFO - PROCESS | 5701 | 02:29:36 INFO - PROCESS | 5701 | [#0] dojo.html Cycles:165 Average:5533.97 Median:5713.74 stddev:634.81 (11.1%) stddev-sans-first:609.47 02:29:36 INFO - PROCESS | 5701 | Values: 3186.7 3242.5 3250.3 3278.7 3294.3 5501.8 5511.2 5529.1 5562.5 5568.1 5424.7 5575.0 5597.7 5604.8 5634.3 5008.1 5039.4 5128.9 5156.9 5164.4 5047.6 5205.9 5238.6 5250.2 5254.8 4988.7 4996.3 5037.2 5082.8 5092.4 5046.7 5056.0 5056.8 5066.5 5111.5 5004.3 5033.1 5039.2 5042.6 5080.5 5473.8 5495.1 5510.6 5524.9 5555.4 6013.1 6026.8 6045.9 6047.4 6053.9 5820.4 5871.0 5956.4 6018.7 6035.4 5552.4 5567.8 5650.6 5651.5 5690.1 6178.0 6183.3 6204.1 6204.3 6222.6 5742.1 5953.1 5959.9 5960.2 5968.8 5886.1 5935.4 5991.1 5991.4 6026.0 5802.3 5854.7 5924.8 5985.9 6013.5 5916.1 5962.4 5962.7 5963.1 5964.1 4437.5 4468.0 4476.6 4487.2 4505.5 3991.2 4005.2 4010.9 4035.3 4049.3 5483.6 5591.6 5612.3 5641.2 5652.7 5916.6 5942.2 5956.1 5967.5 5991.7 5591.9 5603.0 5641.3 5657.8 5668.2 5018.3 5111.4 5113.1 5119.5 5124.8 6096.4 6155.0 6189.7 6205.9 6240.2 5982.1 5995.2 5996.0 6049.4 6055.9 5969.5 6079.5 6087.0 6162.6 6176.3 5920.8 5926.1 5926.3 5937.1 5984.0 5937.5 5955.3 6003.1 6008.3 6020.0 5713.7 5729.9 5817.0 5830.3 5854.2 5658.1 5674.1 5698.9 5783.9 5788.0 5641.1 5684.0 5718.8 5719.3 5719.7 5785.6 5819.6 5857.7 5886.3 5954.2 5625.1 5628.6 5747.5 5755.9 5774.2 02:29:36 INFO - PROCESS | 5701 | 02:29:36 INFO - PROCESS | 5701 | [#1] ext.html Cycles:180 Average:62391.79 Median:41092.69 stddev:132431.42 (322.3%) stddev-sans-first:132721.59 02:29:36 INFO - PROCESS | 5701 | Values: 571.8 618.4 623.2 639.8 644.8 37796.4 42510.8 42628.6 42758.6 42971.6 42695.8 42939.0 42999.4 43025.4 43041.6 8654.1 8762.5 8768.0 8769.7 8788.7 8696.6 8716.0 8753.8 8754.5 8755.3 8776.1 8787.0 8791.3 8812.8 8824.7 8640.5 8652.0 8664.4 8722.6 8751.6 8632.7 8635.6 8676.7 8693.8 8701.0 40800.6 41225.0 41280.8 41296.6 41395.0 3476.0 3600.2 3616.9 3680.2 3704.6 32197.2 32528.3 32721.0 32882.0 33627.3 4346.6 4360.8 4398.7 4403.9 4489.1 354590.0 354921.0 355184.0 355921.0 356810.0 33292.8 34100.7 57525.0 58052.1 58071.0 36543.5 36620.1 36628.3 36664.5 36710.4 15378.0 15516.2 15531.7 15590.2 15617.4 12868.9 12991.5 13046.5 13065.7 13109.6 8290.0 8304.5 8386.0 8388.4 8429.3 3285.7 3287.4 3316.8 3317.1 3338.0 1044.7 1079.6 1100.5 1100.5 1172.6 30676.0 32269.4 32617.5 32647.7 33010.0 1160.0 1175.9 1219.0 1222.7 1272.7 16779.4 17064.1 17291.3 17292.3 17496.4 607647.0 608437.0 612285.0 617337.0 617446.0 57778.0 58173.7 58498.4 58613.0 58674.7 1342.8 1385.7 1388.6 1397.7 1403.3 29252.3 30319.8 30506.7 30726.5 31045.4 51557.5 51610.2 51952.0 52075.7 52220.0 483116.0 485244.0 487126.0 488275.0 489079.0 27790.0 27931.2 28213.7 28421.9 28570.0 47359.0 48125.5 48499.3 48539.0 48816.8 40606.7 41698.0 41706.4 41955.6 42704.4 40960.4 41710.8 41817.0 42117.2 42202.0 34063.8 34663.8 35213.3 35573.6 40296.6 35378.6 37229.0 37660.6 37743.6 37827.2 27800.7 28646.9 28843.6 28849.9 29008.6 02:29:36 INFO - PROCESS | 5701 | 02:29:36 INFO - PROCESS | 5701 | [#2] jquery.html Cycles:180 Average:29664.20 Median:12258.61 stddev:85267.27 (695.6%) stddev-sans-first:85478.13 02:29:36 INFO - PROCESS | 5701 | Values: 388.3 391.3 394.0 397.9 415.9 14250.0 15448.3 18382.4 19727.8 19857.6 15689.8 17905.8 18720.7 18750.0 18753.5 5261.1 5304.8 5781.4 5900.8 5947.2 5789.9 5810.0 5827.7 5840.4 5840.9 5265.8 5339.2 5359.5 5380.1 5680.2 5296.3 5371.3 5396.6 5421.9 5423.7 5009.3 5288.5 5300.5 5373.8 5403.7 13705.2 13906.6 14056.6 19201.5 22291.2 2226.0 2512.9 2588.8 2919.7 2922.9 9912.5 10079.8 10107.9 10272.4 10357.2 1852.2 1928.0 1952.4 1952.7 1967.1 80918.6 81528.2 82286.2 82866.2 84529.0 11078.3 11112.5 11295.8 11313.3 11346.7 15398.8 15406.5 15451.8 15662.1 15679.5 7206.2 7350.9 8125.8 8299.3 8623.0 7346.5 7438.2 7737.0 7841.5 7848.5 4726.3 4769.3 4827.3 4875.6 4889.8 1951.4 1980.9 1994.5 2005.8 2019.4 948.4 1015.1 1016.2 1024.7 1046.8 19075.8 19368.3 19541.7 19543.9 19615.3 936.8 983.5 1022.9 1059.8 1060.5 10399.4 10833.3 10917.9 10919.6 10969.8 513142.0 513793.3 517194.0 519055.0 520037.0 96969.5 98805.0 99086.5 100178.5 100384.0 1008.7 1026.1 1052.8 1079.2 1079.4 16590.9 16594.4 16670.2 16696.2 16905.7 39264.8 41137.6 41942.2 42273.0 43933.1 48404.3 58763.4 59750.0 60418.7 60587.1 8413.3 8521.0 8643.0 8680.1 8712.7 9305.8 13162.1 13435.5 13460.1 13475.9 10992.2 11242.2 11393.7 11631.3 12231.0 11621.7 11722.1 11725.8 11900.5 11997.5 11829.7 11908.8 12092.2 12144.5 12283.6 8709.3 8855.6 8909.9 9069.7 9091.1 9082.1 11009.4 11266.0 12189.8 12192.9 02:29:36 INFO - PROCESS | 5701 | 02:29:36 INFO - PROCESS | 5701 | [#3] mootools.html Cycles:180 Average:5772.66 Median:4570.19 stddev:3310.41 (72.4%) stddev-sans-first:3303.99 02:29:36 INFO - PROCESS | 5701 | Values: 1480.8 1504.2 1601.7 1739.0 1753.0 7610.6 8189.5 8271.8 8868.6 8877.1 8242.5 8457.4 8468.3 8544.4 8561.8 2258.7 2319.1 2322.8 2329.5 2332.7 2279.4 2311.5 2330.6 2343.3 2349.8 2326.9 2332.5 2333.9 2349.6 2353.5 2285.0 2287.1 2298.3 2320.0 2339.4 2289.7 2306.5 2309.8 2315.7 2321.2 8452.3 8518.0 8527.6 8529.6 8531.4 5128.3 5211.1 5238.4 5245.5 5250.0 3272.7 3383.4 3456.4 3471.4 3480.3 1134.6 1162.4 1168.2 1172.5 1186.9 12335.2 12356.0 12361.0 12368.6 12468.1 4549.6 4590.8 4659.9 4697.3 4715.0 10376.5 10405.3 10405.8 10408.2 10420.0 5155.2 5155.4 5211.6 5295.1 5308.9 4177.5 4619.0 4792.5 4806.8 4862.6 3903.6 3910.8 3991.2 3999.8 4040.8 1211.3 1214.8 1220.6 1229.9 1238.2 1012.1 1033.0 1033.1 1033.8 1035.5 5868.8 6035.1 6037.3 6210.9 6236.0 471.5 477.5 478.6 480.7 486.1 4180.7 4184.4 4191.5 4213.3 4233.3 10767.7 11011.6 11073.7 11120.7 11165.1 10753.4 10919.2 10976.5 11028.3 11066.2 7745.5 8044.8 8079.6 8240.0 8254.5 5871.3 6069.6 6122.7 6163.8 6219.5 9940.2 10142.3 10261.9 10284.5 10345.6 10263.3 10462.6 10509.3 10573.0 10584.6 7105.4 7506.5 7672.2 7755.0 7780.6 8534.6 8559.3 8571.8 8606.8 8626.2 7507.5 7790.0 7791.3 7840.2 7851.6 7515.1 7525.7 7528.2 7571.0 7771.2 6575.4 6596.1 6618.2 6675.9 6678.4 4947.0 5031.1 5046.2 5152.0 5236.4 5148.3 5154.1 5170.2 5253.7 5290.5 02:29:36 INFO - PROCESS | 5701 | 02:29:36 INFO - PROCESS | 5701 | [#4] prototype.html Cycles:180 Average:4994.02 Median:5650.79 stddev:1483.08 (26.2%) stddev-sans-first:1445.41 02:29:36 INFO - PROCESS | 5701 | Values: 334.1 334.8 338.4 338.9 341.2 5585.4 5688.3 5690.3 5707.8 5737.2 5549.0 5570.0 5570.6 5582.0 5641.4 4151.8 4270.3 4304.9 4360.5 4368.1 4347.0 4383.8 4403.3 4411.5 4430.8 4379.5 4384.0 4393.7 4399.6 4406.5 4264.8 4318.8 4319.2 4367.3 4374.8 3839.7 3847.8 3863.2 3875.9 3893.6 5411.3 5413.1 5444.7 5448.6 5470.7 4855.6 5010.3 5026.3 5042.8 5043.5 5813.0 5884.3 5887.8 5906.7 5947.6 4247.7 4251.0 4257.5 4259.7 4263.1 5964.0 6057.5 6086.7 6136.1 6142.2 4371.7 4372.9 4379.5 4380.1 4386.0 4404.5 4435.6 4437.3 4454.4 4460.4 4702.9 4943.2 4957.6 4971.4 5065.3 5938.9 5958.9 5978.1 5980.6 6000.2 1468.9 1489.4 1494.4 1497.8 1502.5 961.7 986.7 999.0 1002.5 1012.3 5536.2 5546.6 5590.2 5609.9 5641.8 5947.5 5969.6 6004.3 6032.8 6033.3 5467.6 5565.6 5704.5 5763.1 5764.7 3215.3 3228.7 3256.7 3275.6 3283.2 6222.4 6308.4 6337.9 6338.7 6365.5 6211.9 6234.7 6248.3 6254.3 6272.5 6111.3 6289.4 6356.9 6394.8 6421.3 6093.7 6124.0 6127.8 6136.6 6175.5 6034.2 6104.8 6139.2 6139.2 6170.3 6111.7 6235.1 6376.7 6402.4 6426.1 4267.0 4268.4 4287.5 4307.3 4310.6 5902.5 6171.0 6172.5 6240.6 6277.9 6020.6 6032.8 6053.8 6064.3 6066.0 5978.3 6038.0 6043.7 6043.9 6058.3 5549.9 5842.2 5848.0 5855.2 5902.6 5886.5 5957.5 5966.5 6002.4 6012.4 5659.8 5848.4 5865.3 5937.6 5944.6 02:29:36 INFO - PROCESS | 5701 | 02:29:36 INFO - PROCESS | 5701 | [#5] yui.html Cycles:180 Average:20972.65 Median:3794.62 stddev:30356.96 (800.0%) stddev-sans-first:30404.12 02:29:36 INFO - PROCESS | 5701 | Values: 744.7 750.5 790.5 816.9 829.8 14837.0 15474.8 15942.0 15997.4 16017.8 14746.9 14778.5 15108.0 15585.8 15653.7 810.2 812.5 815.4 816.1 816.5 786.6 802.2 803.8 828.6 830.6 844.7 851.5 852.7 855.6 857.1 840.9 853.2 853.8 854.3 855.4 619.5 620.9 623.5 624.0 625.7 15592.0 15692.3 15700.0 15703.4 15717.6 14730.4 14809.0 14897.6 15022.8 15082.8 12276.9 12350.0 12464.4 12544.5 12802.1 3559.9 3606.7 3683.7 3755.8 3771.5 78548.6 78797.2 79851.2 80124.6 80335.6 10783.9 11102.8 11339.4 11554.2 11560.8 21276.7 21462.7 21651.9 21656.2 21696.9 8368.2 8639.0 8852.0 8983.2 9206.6 4674.2 4907.5 5024.1 5026.7 5037.5 3645.4 3774.5 3793.9 3795.3 3813.8 619.1 631.4 638.2 638.4 641.9 656.7 743.5 749.9 770.8 775.5 9535.3 9875.0 10080.8 10091.9 10627.6 668.0 773.9 775.0 779.8 800.8 4651.5 4700.2 4847.0 4934.4 5147.8 109757.9 110708.0 115989.0 119673.0 119685.4 100307.5 101350.0 101981.0 102234.0 102673.0 84745.6 85334.6 87813.6 88460.0 89720.1 9420.9 9452.1 9503.6 9576.7 9580.5 52835.9 52925.2 53475.7 54178.0 54282.2 67908.0 68795.3 74118.6 75886.6 76539.6 12076.5 12231.6 12261.3 12623.4 12730.0 13627.1 13714.3 13992.6 14172.8 14452.4 11802.5 11813.8 11992.6 12127.6 12512.1 12944.6 13237.3 13249.0 13285.5 13370.4 12141.9 12392.5 12487.1 12517.1 13007.7 10558.2 10743.9 10772.8 10788.8 11208.7 10974.2 11058.3 11064.3 11096.3 11103.7 02:29:36 INFO - PROCESS | 5701 | -------- Summary: end -------- 02:29:36 INFO - PROCESS | 5701 | 02:29:37 INFO - TEST-INFO | 5701: exit 0 02:29:37 INFO - TEST-OK | dromaeo_css | took 1111793ms 02:29:37 INFO - TEST-START | kraken 02:29:37 INFO - operating with platform_type : linux_ 02:29:37 INFO - Initialising browser for kraken test... 02:29:37 INFO - TEST-INFO | started process 5934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphsMlLj/profile http://localhost:44984/getInfo.html) 02:29:42 INFO - PROCESS | 5934 | __metrics Screen width/height:1600/1200 02:29:42 INFO - PROCESS | 5934 | colorDepth:24 02:29:42 INFO - PROCESS | 5934 | Browser inner width/height: 1024/697 02:29:42 INFO - PROCESS | 5934 | __metrics 02:29:43 ERROR - PROCESS | 5934 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 02:29:43 INFO - TEST-INFO | 5934: exit 0 02:29:43 INFO - Browser initialized. 02:29:43 INFO - Running cycle 1/1 for kraken test... 02:29:43 INFO - TEST-INFO | started process 6053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphsMlLj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:55 INFO - PROCESS | 6053 | RSS: Main: 167436288 02:29:55 INFO - PROCESS | 6053 | 02:29:58 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:44984/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44984/tests/kraken/driver.html?testName=audio-beat-detection) 02:29:59 INFO - PROCESS | 6053 | RSS: Main: 173142016 02:29:59 INFO - PROCESS | 6053 | 02:30:01 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:44984/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44984/tests/kraken/driver.html?testName=audio-dft) 02:30:02 INFO - PROCESS | 6053 | RSS: Main: 172208128 02:30:02 INFO - PROCESS | 6053 | 02:30:05 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:44984/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44984/tests/kraken/driver.html?testName=audio-fft) 02:30:05 INFO - PROCESS | 6053 | RSS: Main: 167190528 02:30:05 INFO - PROCESS | 6053 | 02:30:08 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:44984/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44984/tests/kraken/driver.html?testName=audio-oscillator) 02:30:08 INFO - PROCESS | 6053 | RSS: Main: 168288256 02:30:08 INFO - PROCESS | 6053 | 02:30:11 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:44984/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44984/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:30:11 INFO - PROCESS | 6053 | RSS: Main: 168787968 02:30:11 INFO - PROCESS | 6053 | 02:30:14 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:44984/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44984/tests/kraken/driver.html?testName=imaging-darkroom) 02:30:15 INFO - PROCESS | 6053 | RSS: Main: 168816640 02:30:15 INFO - PROCESS | 6053 | 02:30:18 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:44984/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44984/tests/kraken/driver.html?testName=imaging-desaturate) 02:30:19 INFO - PROCESS | 6053 | RSS: Main: 166350848 02:30:19 INFO - PROCESS | 6053 | 02:30:22 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:44984/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44984/tests/kraken/driver.html?testName=json-parse-financial) 02:30:23 INFO - PROCESS | 6053 | RSS: Main: 167481344 02:30:23 INFO - PROCESS | 6053 | 02:30:24 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:44984/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44984/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:30:25 INFO - PROCESS | 6053 | RSS: Main: 168108032 02:30:25 INFO - PROCESS | 6053 | 02:30:27 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:44984/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44984/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:30:27 INFO - PROCESS | 6053 | RSS: Main: 168325120 02:30:27 INFO - PROCESS | 6053 | 02:30:29 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:44984/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44984/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:30:30 INFO - PROCESS | 6053 | RSS: Main: 168755200 02:30:30 INFO - PROCESS | 6053 | 02:30:33 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:44984/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44984/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:30:33 INFO - PROCESS | 6053 | RSS: Main: 169279488 02:30:33 INFO - PROCESS | 6053 | 02:30:36 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:44984/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44984/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:30:37 INFO - PROCESS | 6053 | RSS: Main: 168566784 02:30:37 INFO - PROCESS | 6053 | 02:30:38 INFO - PROCESS | 6053 | Cycle 1(1): loaded http://localhost:44984/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44984/tests/kraken/driver.html?testName=ai-astar) 02:30:38 INFO - PROCESS | 6053 | RSS: Main: 169213952 02:30:38 INFO - PROCESS | 6053 | 02:30:38 INFO - PROCESS | 6053 | __start_tp_report 02:30:38 INFO - PROCESS | 6053 | _x_x_mozilla_page_load 02:30:38 INFO - PROCESS | 6053 | _x_x_mozilla_page_load_details 02:30:38 INFO - PROCESS | 6053 | |i|pagename|runs| 02:30:38 INFO - PROCESS | 6053 | |0;ai-astar;112;106;113;111;112;115;110;109;110;109 02:30:38 INFO - PROCESS | 6053 | |1;audio-beat-detection;170;127;157;175;126;166;160;127;199;136 02:30:38 INFO - PROCESS | 6053 | |2;audio-dft;162;161;161;163;163;166;166;163;161;162 02:30:38 INFO - PROCESS | 6053 | |3;audio-fft;78;76;75;159;75;74;74;76;166;76 02:30:38 INFO - PROCESS | 6053 | |4;audio-oscillator;84;84;153;85;86;85;150;86;85;142 02:30:38 INFO - PROCESS | 6053 | |5;imaging-gaussian-blur;117;118;117;118;118;118;121;118;118;118 02:30:38 INFO - PROCESS | 6053 | |6;imaging-darkroom;149;147;147;148;147;147;148;146;147;149 02:30:38 INFO - PROCESS | 6053 | |7;imaging-desaturate;95;95;97;96;95;95;96;95;96;96 02:30:38 INFO - PROCESS | 6053 | |8;json-parse-financial;56;57;57;56;56;56;58;59;56;57 02:30:38 INFO - PROCESS | 6053 | |9;json-stringify-tinderbox;60;61;60;61;62;61;61;60;60;60 02:30:38 INFO - PROCESS | 6053 | |10;stanford-crypto-aes;80;85;82;82;80;80;87;81;107;82 02:30:38 INFO - PROCESS | 6053 | |11;stanford-crypto-ccm;133;123;123;121;121;133;124;133;122;121 02:30:38 INFO - PROCESS | 6053 | |12;stanford-crypto-pbkdf2;166;164;166;160;159;158;159;170;158;162 02:30:38 INFO - PROCESS | 6053 | |13;stanford-crypto-sha256-iterative;63;63;68;63;63;63;62;66;62;64 02:30:38 INFO - PROCESS | 6053 | __end_tp_report 02:30:38 INFO - PROCESS | 6053 | __start_cc_report 02:30:38 INFO - PROCESS | 6053 | _x_x_mozilla_cycle_collect,885 02:30:38 INFO - PROCESS | 6053 | __end_cc_report 02:30:38 INFO - PROCESS | 6053 | __startTimestamp1465464638952__endTimestamp 02:30:38 INFO - PROCESS | 6053 | 02:30:38 INFO - PROCESS | 6053 | ------- Summary: start ------- 02:30:38 INFO - PROCESS | 6053 | Number of tests: 14 02:30:38 INFO - PROCESS | 6053 | 02:30:38 INFO - PROCESS | 6053 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:2.50 (2.2%) stddev-sans-first:2.60 02:30:38 INFO - PROCESS | 6053 | Values: 112.0 106.0 113.0 111.0 112.0 115.0 110.0 109.0 110.0 109.0 02:30:38 INFO - PROCESS | 6053 | 02:30:38 INFO - PROCESS | 6053 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:163.00 stddev:24.67 (15.1%) stddev-sans-first:25.50 02:30:38 INFO - PROCESS | 6053 | Values: 170.0 127.0 157.0 175.0 126.0 166.0 160.0 127.0 199.0 136.0 02:30:38 INFO - PROCESS | 6053 | 02:30:38 INFO - PROCESS | 6053 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.87 (1.1%) stddev-sans-first:1.96 02:30:38 INFO - PROCESS | 6053 | Values: 162.0 161.0 161.0 163.0 163.0 166.0 166.0 163.0 161.0 162.0 02:30:38 INFO - PROCESS | 6053 | 02:30:38 INFO - PROCESS | 6053 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.50 stddev:36.74 (48.7%) stddev-sans-first:38.57 02:30:38 INFO - PROCESS | 6053 | Values: 78.0 76.0 75.0 159.0 75.0 74.0 74.0 76.0 166.0 76.0 02:30:38 INFO - PROCESS | 6053 | 02:30:38 INFO - PROCESS | 6053 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:85.00 stddev:30.72 (36.1%) stddev-sans-first:31.72 02:30:38 INFO - PROCESS | 6053 | Values: 84.0 84.0 153.0 85.0 86.0 85.0 150.0 86.0 85.0 142.0 02:30:38 INFO - PROCESS | 6053 | 02:30:38 INFO - PROCESS | 6053 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.10 (0.9%) stddev-sans-first:1.09 02:30:38 INFO - PROCESS | 6053 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 121.0 118.0 118.0 118.0 02:30:38 INFO - PROCESS | 6053 | 02:30:38 INFO - PROCESS | 6053 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.97 (0.7%) stddev-sans-first:0.87 02:30:38 INFO - PROCESS | 6053 | Values: 149.0 147.0 147.0 148.0 147.0 147.0 148.0 146.0 147.0 149.0 02:30:38 INFO - PROCESS | 6053 | 02:30:38 INFO - PROCESS | 6053 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 02:30:38 INFO - PROCESS | 6053 | Values: 95.0 95.0 97.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 02:30:38 INFO - PROCESS | 6053 | 02:30:38 INFO - PROCESS | 6053 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:1.03 (1.8%) stddev-sans-first:1.05 02:30:38 INFO - PROCESS | 6053 | Values: 56.0 57.0 57.0 56.0 56.0 56.0 58.0 59.0 56.0 57.0 02:30:38 INFO - PROCESS | 6053 | 02:30:38 INFO - PROCESS | 6053 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 02:30:38 INFO - PROCESS | 6053 | Values: 60.0 61.0 60.0 61.0 62.0 61.0 61.0 60.0 60.0 60.0 02:30:38 INFO - PROCESS | 6053 | 02:30:38 INFO - PROCESS | 6053 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:82.00 stddev:8.19 (10.0%) stddev-sans-first:8.52 02:30:38 INFO - PROCESS | 6053 | Values: 80.0 85.0 82.0 82.0 80.0 80.0 87.0 81.0 107.0 82.0 02:30:38 INFO - PROCESS | 6053 | 02:30:38 INFO - PROCESS | 6053 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:123.50 stddev:5.34 (4.3%) stddev-sans-first:4.90 02:30:38 INFO - PROCESS | 6053 | Values: 133.0 123.0 123.0 121.0 121.0 133.0 124.0 133.0 122.0 121.0 02:30:38 INFO - PROCESS | 6053 | 02:30:38 INFO - PROCESS | 6053 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:163.00 stddev:4.13 (2.5%) stddev-sans-first:4.15 02:30:38 INFO - PROCESS | 6053 | Values: 166.0 164.0 166.0 160.0 159.0 158.0 159.0 170.0 158.0 162.0 02:30:38 INFO - PROCESS | 6053 | 02:30:38 INFO - PROCESS | 6053 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.00 stddev:1.89 (3.0%) stddev-sans-first:1.99 02:30:38 INFO - PROCESS | 6053 | Values: 63.0 63.0 68.0 63.0 63.0 63.0 62.0 66.0 62.0 64.0 02:30:38 INFO - PROCESS | 6053 | -------- Summary: end -------- 02:30:38 INFO - PROCESS | 6053 | 02:30:39 INFO - TEST-INFO | 6053: exit 0 02:30:39 INFO - TEST-OK | kraken | took 62568ms 02:30:39 INFO - SUITE-END | took 1174s 02:30:40 INFO - Completed test suite (00:19:34) 02:30:40 INFO - javascript benchmark 02:30:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7279.573201515307, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3186.7450603951684, 3242.4974129009997, 3250.2849373137915, 3278.7213086887614, 3294.308195278991, 5501.807436739715, 5511.173324001402, 5529.142982837661, 5562.527185189264, 5568.136938774496, 5424.701641409721, 5575.0, 5597.692126933017, 5604.8038318658855, 5634.32388113427, 5008.098542262392, 5039.420466646346, 5128.948710512903, 5156.896862062757, 5164.406093299281, 5047.621428392867, 5205.9219111713355, 5238.60710446718, 5250.18622113573, 5254.7635356409055, 4988.650794444408, 4996.325496058022, 5037.244413337992, 5082.847514574569, 5092.363454568179, 5046.7224302663335, 5056.0, 5056.84829455117, 5066.530706095228, 5111.539961403454, 5004.299398084271, 5033.0688822567945, 5039.193729003342, 5042.647014708972, 5080.466551012128, 5473.8357849264585, 5495.093309603911, 5510.586705997066, 5524.889502209933, 5555.444455554452, 6013.067974463965, 6026.758929642809, 6045.909311360333, 6047.425494578008, 6053.909191362133, 5820.388859169769, 5870.97064514679, 5956.434138756811, 6018.6990650467305, 6035.366286539894, 5552.361478429992, 5567.805126820583, 5650.576206784466, 5651.547876169938, 5690.061139911951, 6178.0, 6183.258009038944, 6204.100405441186, 6204.255489341308, 6222.62664240147, 5742.052561327418, 5953.1070339449425, 5959.910601340984, 5960.195373624592, 5968.761249550056, 5886.05823068307, 5935.376785437467, 5991.131285963511, 5991.400859914061, 6026.0, 5802.33273173582, 5854.677992710356, 5924.763009479572, 5985.850353741104, 6013.54898382623, 5916.112583112482, 5962.433568810956, 5962.731677074542, 5963.105534169909, 5964.105384192406, 4437.467503899553, 4468.03937153507, 4476.574725401082, 4487.237169681162, 4505.526919673387, 3991.1618560102124, 4005.239004589119, 4010.939835902464, 4035.29382358092, 4049.2913740095364, 5483.643563168382, 5591.580631452657, 5612.326520817528, 5641.182028605829, 5652.717364131777, 5916.5858389913155, 5942.168096466498, 5956.136360227742, 5967.492763115184, 5991.700414979234, 5591.916121258185, 5602.97198514013, 5641.26663533738, 5657.830265091971, 5668.206451096849, 5018.272350509155, 5111.412187598474, 5113.080623590223, 5119.462456442095, 5124.769385377667, 6096.420840020191, 6155.0, 6189.721462534197, 6205.937940620626, 6240.157578726905, 5982.1325907744, 5995.220621319288, 5996.040633498619, 6049.4447790315535, 6055.9091613626715, 5969.492593129633, 6079.513638908788, 6086.969565152146, 6162.599431036968, 6176.289726681489, 5920.79277225295, 5926.140709597171, 5926.318473375617, 5937.139114828412, 5984.0, 5937.495312898452, 5955.285365756137, 6003.129546215861, 6008.279006519246, 6019.969900150471, 5713.7428815704225, 5729.885402292014, 5817.040188368872, 5830.329512106162, 5854.180414742024, 5658.066419040977, 5674.120511320752, 5698.886022279614, 5783.913241301468, 5788.0, 5641.069223578063, 5684.033714268667, 5718.79984200551, 5719.3136823581435, 5719.742611582572, 5785.566082543742, 5819.592628515963, 5857.677827719516, 5886.293644762484, 5954.225950626391, 5625.071863142535, 5628.577856660685, 5747.511461525817, 5755.8561035974435, 5774.162746401664], "value": 5490.818971505025, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.8084441712026, 618.3723520626563, 623.1836294454263, 639.8144538083955, 644.8162273751982, 37796.43305350422, 42510.7874460628, 42628.57371426285, 42758.572414275885, 42971.570284297144, 42695.78652106735, 42939.0, 42999.3550096748, 43025.35461968073, 43041.56958430415, 8654.09132041136, 8762.474251544896, 8768.035516093225, 8769.736907892742, 8788.69239576615, 8696.608652610648, 8716.041235464094, 8753.824923501526, 8754.474731516098, 8755.343349248831, 8776.07851175627, 8787.0, 8791.340649451286, 8812.779680507974, 8824.735257942271, 8640.524771137585, 8652.04827468978, 8664.350173736995, 8722.607482663296, 8751.606177722018, 8632.741017769415, 8635.611397487128, 8676.696315628986, 8693.782655433664, 8701.0, 40800.59199407998, 41225.0, 41280.79359603183, 41296.58703412987, 41395.0, 3476.0222059868825, 3600.1539638185004, 3616.9095772605897, 3680.1719613087107, 3704.592494825567, 32197.235711617483, 32528.349433011208, 32721.0, 32882.0, 33627.327453450795, 4346.587074227943, 4360.7819609019425, 4398.670099742532, 4403.867883963486, 4489.057297967431, 354590.0, 354921.0, 355184.0, 355921.0, 356810.0, 33292.83353583265, 34100.658993410245, 57525.0, 58052.12921806176, 58071.0, 36543.4518482223, 36620.084497887234, 36628.267434651156, 36664.45003324952, 36710.449343259876, 15378.0, 15516.224188790515, 15531.689366212613, 15590.220488975507, 15617.3753049879, 12868.935655321664, 12991.480340786262, 13046.47814087445, 13065.673358166121, 13109.606711798471, 8290.046644635824, 8304.543250121302, 8386.035605905277, 8388.412811103286, 8429.283510901641, 3285.704286614216, 3287.4247006773717, 3316.7844090134063, 3317.0712200583876, 3337.9666203338143, 1044.7335929337971, 1079.6167360586878, 1100.4717735486852, 1100.4882729530646, 1172.648205538335, 30676.0, 32269.35461290761, 32617.51073733896, 32647.673523264937, 33010.0, 1159.9942000290114, 1175.9118066145074, 1219.0, 1222.6882145052955, 1272.6563827766636, 16779.412720554723, 17064.146792660318, 17291.308347665952, 17292.308307667805, 17496.387626433014, 607647.0, 608437.0, 612285.0, 617337.0, 617446.0, 57778.0, 58173.709131454074, 58498.41501585015, 58613.0, 58674.70662646745, 1342.7918672605763, 1385.743637427059, 1388.6181300142541, 1397.6575738944023, 1403.305363844883, 29252.268693282836, 30319.848400757855, 30506.694933050385, 30726.539101913935, 31045.379092418476, 51557.48442515527, 51610.22584661308, 51952.0, 52075.739621301655, 52220.0, 483116.0, 485244.0, 487126.0, 488275.0, 489079.0, 27790.0, 27931.16206513808, 28213.717862821108, 28421.857890710413, 28570.0, 47359.0, 48125.51874481211, 48499.27251091307, 48539.0, 48816.755916220194, 40606.736292690024, 41698.0, 41706.37440438335, 41955.58044419517, 42704.35943460788, 40960.38559421551, 41710.791446042575, 41817.0, 42117.1576568473, 42202.0, 34063.829680851435, 34663.826680866434, 35213.29573408569, 35573.644263557035, 40296.597034030456, 35378.58485660545, 37229.0, 37660.62339376571, 37743.62256377401, 37827.24345513129, 27800.721992779814, 28646.85676571604, 28843.5673464894, 28849.855750721952, 29008.564871527367], "value": 18998.021611710225, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.2952441319004, 391.3308242904633, 393.99212015759684, 397.85279446604756, 415.94176815245874, 14250.0, 15448.304826282816, 18382.356617518373, 19727.80272197276, 19857.60284794303, 15689.764653530206, 17905.82094179058, 18720.719189212137, 18749.96875171865, 18753.531161720963, 5261.079311120558, 5304.761285742132, 5781.364049954502, 5900.822975310747, 5947.1971283876555, 5789.855253618651, 5810.0, 5827.650340979533, 5840.415958404168, 5840.941590584082, 5265.842024739245, 5339.199120131992, 5359.517643412092, 5380.139177731564, 5680.233168522238, 5296.25852380667, 5371.328583927009, 5396.622236443451, 5421.864453388657, 5423.674579525202, 5009.323741294915, 5288.497592728685, 5300.469953004668, 5373.838784836461, 5403.729813509348, 13705.177689338572, 13906.58280251594, 14056.648583785487, 19201.519962000923, 22291.219807306665, 2226.0, 2512.944563283407, 2588.8187826852127, 2919.7080291970633, 2922.8684709188137, 9912.504374781303, 10079.848802267972, 10107.89892101077, 10272.435016074112, 10357.171426285879, 1852.2220667319757, 1927.9807201927943, 1952.4142757172792, 1952.726618273443, 1967.0754745269844, 80918.59540702259, 81528.18471815325, 82286.17713822845, 82866.17133828584, 84529.0, 11078.335299882034, 11112.499937502831, 11295.830562541569, 11313.321200727984, 11346.659600212008, 15398.846011539741, 15406.460773872861, 15451.845481545266, 15662.138582378078, 15679.451219207273, 7206.207317195104, 7350.926490735131, 8125.75622731319, 8299.336053115736, 8623.0, 7346.485745997729, 7438.181800001996, 7737.0, 7841.451098423056, 7848.529088254609, 4726.338312636233, 4769.260764581495, 4827.348307978378, 4875.585575226075, 4889.828855990023, 1951.3853136262032, 1980.8613397062356, 1994.4814348269554, 2005.7994200580117, 2019.4042757386605, 948.3693343926212, 1015.0712098429854, 1016.1667432705111, 1024.6516184497307, 1046.8115739167024, 19075.809899687727, 19368.322108726126, 19541.706874396896, 19543.902280488506, 19615.31346402869, 936.8454205056225, 983.5229913491951, 1022.8516865054675, 1059.7615536504225, 1060.4909643371225, 10399.428031458343, 10833.349999000086, 10917.945410272898, 10919.617813376653, 10969.83545246822, 513142.0, 513793.2931006038, 517194.0, 519055.0, 520037.0, 96969.51515242379, 98805.0, 99086.50456747814, 100178.49910750546, 100384.0, 1008.742770593494, 1026.0970346095537, 1052.7947050325113, 1079.1636481726725, 1079.4171147580375, 16590.917045414695, 16594.419195328104, 16670.16649167561, 16696.248668810174, 16905.74641380405, 39264.803675981435, 41137.58862411338, 41942.16115677731, 42273.0, 43933.121337573706, 48404.27393589028, 58763.412365877506, 59750.0, 60418.697906510184, 60587.09119363125, 8413.3269338454, 8520.957395212985, 8643.0, 8680.088590697886, 8712.651493940171, 9305.813883722152, 13162.14446061003, 13435.462581496631, 13460.125091868997, 13475.932620336836, 10992.230543861853, 11242.156838237328, 11393.658190254306, 11631.302121872715, 12231.0, 11621.6513504595, 11722.120840937134, 11725.824112638147, 11900.464479098287, 11997.520099196283, 11829.704257393634, 11908.76182476363, 12092.15354925182, 12144.514219431123, 12283.57007504733, 8709.259712924473, 8855.557222138996, 8909.933807670222, 9069.682561110329, 9091.09089091112, 9082.137196966278, 11009.394483303495, 11266.04238639692, 12189.817152742538, 12192.939035304767], "value": 9124.056959855283, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1480.792689023537, 1504.1877386211447, 1601.6796640671869, 1738.9565260868476, 1753.0, 7610.619469026554, 8189.549574773385, 8271.793205169874, 8868.55657217139, 8877.112288771128, 8242.546659933701, 8457.407981441285, 8468.280196183332, 8544.444611100289, 8561.785955351104, 2258.695076164717, 2319.130326127702, 2322.814174866015, 2329.522447898177, 2332.6617640442128, 2279.4073540879326, 2311.503026849227, 2330.5571941331177, 2343.3321503371544, 2349.823763217757, 2326.8952897119584, 2332.5101728636923, 2333.88330583471, 2349.6475528670667, 2353.51752890657, 2284.9543009139725, 2287.0623044551653, 2298.276043046443, 2320.0487800002, 2339.356676913845, 2289.713785776778, 2306.5156317173414, 2309.7690230976937, 2315.6758053872472, 2321.1875843454654, 8452.323814094858, 8517.957410212972, 8527.616257268437, 8529.57352132391, 8531.360147988926, 5128.25640282157, 5211.114110601169, 5238.397584277781, 5245.501677340647, 5250.0, 3272.689094536015, 3383.4079036168573, 3456.4469684850555, 3471.444568868994, 3480.3387356402454, 1134.6142311614008, 1162.3665102519146, 1168.1589255735857, 1172.5192671004932, 1186.857577090746, 12335.198212116273, 12356.0, 12361.0, 12368.567100151542, 12468.127231093828, 4549.567791059844, 4590.816367345269, 4659.930101048487, 4697.318888761179, 4715.033418149271, 10376.533056012497, 10405.27163098591, 10405.84391234132, 10408.219383546264, 10420.0, 5155.200943853709, 5155.355580552431, 5211.635185536976, 5295.073362161606, 5308.893822123536, 4177.540470548237, 4618.953810461852, 4792.496787837227, 4806.759662016955, 4862.586680132157, 3903.5510916244993, 3910.843566257318, 3991.2416640838146, 3999.8200080996426, 4040.777757223322, 1211.3458732284644, 1214.8117041858527, 1220.5666988219054, 1229.9200551964093, 1238.1642391385778, 1012.0840639221516, 1032.9793404131876, 1033.1476531861244, 1033.834586466162, 1035.5133087448887, 5868.765249390062, 6035.124906888476, 6037.335893051761, 6210.9068363974575, 6235.96882015587, 471.51905056842514, 477.47000829079695, 478.5788506114597, 480.70917095157625, 486.0716032378141, 4180.686448516373, 4184.3932629768515, 4191.497020357577, 4213.262679031157, 4233.322668373045, 10767.676969690921, 11011.61459348919, 11073.667789966154, 11120.721981950353, 11165.106791456665, 10753.354798712102, 10919.235653504178, 10976.5181700471, 11028.338299702044, 11066.170037247239, 7745.496542724705, 8044.798880028046, 8079.636416361278, 8239.958800206081, 8254.54599996994, 5871.295444546682, 6069.575129740876, 6122.6938653068055, 6163.84590385244, 6219.533534984804, 9940.204783617437, 10142.340747851365, 10261.897381026392, 10284.537195826355, 10345.63790267337, 10263.332883362558, 10462.58149674035, 10509.31689440184, 10573.0, 10584.629537966135, 7105.360517553238, 7506.474546781891, 7672.156062832973, 7754.961225193838, 7780.610969451618, 8534.573271336532, 8559.315254779478, 8571.785705357415, 8606.827863442571, 8626.18051285127, 7507.549547026977, 7790.0, 7791.259830316111, 7840.176781437867, 7851.607419628882, 7515.060617422822, 7525.73659921922, 7528.209537998431, 7570.962145189239, 7771.184025677222, 6575.4410875076155, 6596.142501474777, 6618.172728408949, 6675.933240667531, 6678.432333251728, 4946.985867897, 5031.094403007493, 5046.167382382013, 5152.0, 5236.423993360651, 5148.253503242084, 5154.098032844162, 5170.224466330081, 5253.71104589236, 5290.470952904679], "value": 4555.52661642778, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.11126403765985, 334.81919763327807, 338.3773856104768, 338.9237421580143, 341.2407393549353, 5585.385607583167, 5688.317401911771, 5690.2887139107615, 5707.800226992056, 5737.168110623957, 5549.0289199390145, 5570.025245582017, 5570.637908535942, 5582.0, 5641.407652196522, 4151.750894946305, 4270.295401258804, 4304.913901721964, 4360.542143074979, 4368.060866913613, 4346.97826510867, 4383.846565370212, 4403.339499075132, 4411.514733379326, 4430.759387371541, 4379.4963579188325, 4384.0, 4393.692441529094, 4399.626031787302, 4406.5373135820755, 4264.763218666599, 4318.762468064271, 4319.157764235975, 4367.301231802928, 4374.781260936972, 3839.731218814684, 3847.76913385195, 3863.150106976461, 3875.9418608720894, 3893.5717071122153, 5411.269478620376, 5413.052715774724, 5444.727763611803, 5448.618596698233, 5470.699111548864, 4855.620745834551, 5010.323606313137, 5026.29631851541, 5042.773075211624, 5043.470435604282, 5812.970935145339, 5884.323302820188, 5887.764489420418, 5906.704664766745, 5947.583669143161, 4247.723897946624, 4251.0, 4257.489101307832, 4259.74441533509, 4263.126059157865, 5963.970180149072, 6057.485113765291, 6086.665233412161, 6136.110264011738, 6142.232220972379, 4371.693981421334, 4372.912541749147, 4379.5255680540395, 4380.145871555016, 4385.956140438555, 4404.515503294635, 4435.578620031092, 4437.334399839985, 4454.354118652842, 4460.442444694413, 4702.858914232578, 4943.184374578226, 4957.553820156203, 4971.353724015855, 5065.265536497187, 5938.851528711817, 5958.910616340759, 5978.133170690226, 5980.55145864062, 6000.22993217002, 1468.875145612635, 1489.4265707702396, 1494.4470545898087, 1497.8352381238055, 1502.5267040882088, 961.7497253570331, 986.7335819328741, 998.9710598083985, 1002.468691593442, 1012.2661070723814, 5536.169574563848, 5546.55627549795, 5590.18942253371, 5609.859753506195, 5641.830745077655, 5947.524198064145, 5969.641821490724, 6004.3395226525045, 6032.758689652364, 6033.315174747283, 5467.644603100785, 5565.638233514808, 5704.458076482728, 5763.106718458645, 5764.7117644117625, 3215.2926356201597, 3228.7094161525574, 3256.7135981287734, 3275.623303320149, 3283.228441316289, 6222.439980401695, 6308.400701933309, 6337.9366206337345, 6338.651374174465, 6365.472286651263, 6211.9129152398145, 6234.719437625317, 6248.343923888017, 6254.312025677172, 6272.498200143978, 6111.297200821962, 6289.371062893765, 6356.872862542816, 6394.840128996812, 6421.325760795143, 6093.720318733116, 6124.0, 6127.8468038297615, 6136.601120927304, 6175.475084617858, 6034.185384972972, 6104.80227118246, 6139.201903752483, 6139.219626308321, 6170.3212646607935, 6111.724972376165, 6235.064740288812, 6376.681165941592, 6402.35976402356, 6426.132472116205, 4267.0, 4268.423762791983, 4287.485501739687, 4307.310830267143, 4310.568943105664, 5902.498287645598, 6170.994426811215, 6172.506199504119, 6240.563160578716, 6277.937220627918, 6020.638761674313, 6032.849178770566, 6053.818385448443, 6064.301995441284, 6066.0, 5978.252718410199, 6038.0, 6043.697815109139, 6043.879122417439, 6058.303295121117, 5549.861253468534, 5842.211301474246, 5847.970760146172, 5855.238818953509, 5902.61632993854, 5886.499647530008, 5957.52762603532, 5966.522678185648, 6002.399760024137, 6012.428819262163, 5659.754853932129, 5848.385919478564, 5865.296164460292, 5937.643741375531, 5944.554158438221], "value": 4514.53520750951, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.743063643043, 750.455919458393, 790.4545863354285, 816.9305609023232, 829.842329957308, 14836.961412701115, 15474.845251547482, 15942.0, 15997.360105595792, 16017.839821601781, 14746.852531474682, 14778.482753103644, 15108.0, 15585.84414155858, 15653.686926261496, 810.2140923304386, 812.46377390922, 815.3843847894831, 816.0533780814256, 816.4529765057396, 786.5713186313444, 802.1657476224719, 803.7869964459423, 828.5857071464268, 830.6179157587517, 844.7001314533344, 851.4550687559966, 852.722865068852, 855.5764896376271, 857.0615176381851, 840.9032961209417, 853.2022558907441, 853.7865533616596, 854.2567965869733, 855.448235887852, 619.4734475695668, 620.8727210921795, 623.5198896849446, 623.9532035097386, 625.6715224507125, 15592.0, 15692.293846776809, 15700.0, 15703.371865125382, 15717.607059823482, 14730.410783568645, 14809.0, 14897.553073407815, 15022.774658380133, 15082.849171508255, 12276.938615306866, 12350.0, 12464.43910024042, 12544.498220071186, 12802.103852730312, 3559.9110022249392, 3606.729495287838, 3683.723720720957, 3755.7746535207975, 3771.547414310273, 78548.60725696335, 78797.21202787956, 79851.20148798496, 80124.59937700274, 80335.5983220086, 10783.946080269548, 11102.833457498144, 11339.376334301527, 11554.191206615624, 11560.826587601192, 21276.680849787266, 21462.678059828802, 21651.891740541512, 21656.242031529135, 21696.89151554232, 8368.20502052304, 8638.956805215934, 8851.982022067416, 8983.236424903826, 9206.585703643352, 4674.158651442705, 4907.509249075064, 5024.095662780662, 5026.74866256693, 5037.546620804145, 3645.398509245998, 3774.452704357853, 3793.9241215176094, 3795.316842968237, 3813.84744610218, 619.1115748900343, 631.4348657951108, 638.1831255992245, 638.3871483375918, 641.8940874755706, 656.743869890743, 743.4721347842984, 749.9250074992566, 770.76106407014, 775.4688038693513, 9535.332526723201, 9874.96695875951, 10080.848787268196, 10091.899081009244, 10627.628033018807, 667.9933200667931, 773.860705073081, 774.9573773442402, 779.8245394786128, 800.7757827808223, 4651.534846515389, 4700.224462963641, 4846.975765121152, 4934.383202099738, 5147.794088236428, 109757.86573872673, 110708.0, 115989.0, 119673.0, 119685.40157299332, 100307.49846250722, 101350.0, 101981.0, 102234.0, 102673.0, 84745.57627211824, 85334.5733271342, 87813.56093219621, 88460.0, 89720.10279897117, 9420.858687119562, 9452.149306562442, 9503.61985520599, 9576.715359014572, 9580.520973951136, 52835.94328113339, 52925.20612190743, 53475.73262133665, 54178.0, 54282.185767214316, 67908.0, 68795.31204688089, 74118.62940685477, 75886.62056689902, 76539.61730191314, 12076.45655945467, 12231.633051008484, 12261.26432414058, 12623.431945562288, 12729.981601472045, 13627.058876265977, 13714.314284285547, 13992.580222593338, 14172.787408189091, 14452.421903123757, 11802.52789888395, 11813.76372472563, 11992.620848602173, 12127.636170914886, 12512.124151309685, 12944.611661650166, 13237.27195004284, 13249.0, 13285.468581256642, 13370.398332074885, 12141.878581214074, 12392.504299827906, 12487.063470239587, 12517.123801333819, 13007.674808129872, 10558.155347572023, 10743.892232274371, 10772.784544308914, 10788.838167427339, 11208.65152583452, 10974.231803773979, 11058.336499810037, 11064.336139831636, 11096.278741881752, 11103.72240693989], "value": 7601.689581011628, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 113.0, 111.0, 112.0, 115.0, 110.0, 109.0, 110.0, 109.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 127.0, 157.0, 175.0, 126.0, 166.0, 160.0, 127.0, 199.0, 136.0], "value": 154.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 163.0, 163.0, 166.0, 166.0, 163.0, 161.0, 162.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 75.0, 159.0, 75.0, 74.0, 74.0, 76.0, 166.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 153.0, 85.0, 86.0, 85.0, 150.0, 86.0, 85.0, 142.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 121.0, 118.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 146.0, 147.0, 149.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 56.0, 56.0, 56.0, 58.0, 59.0, 56.0, 57.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 62.0, 61.0, 61.0, 60.0, 60.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 82.0, 82.0, 80.0, 80.0, 87.0, 81.0, 107.0, 82.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 123.0, 123.0, 121.0, 121.0, 133.0, 124.0, 133.0, 122.0, 121.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 166.0, 160.0, 159.0, 158.0, 159.0, 170.0, 158.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 68.0, 63.0, 63.0, 63.0, 62.0, 66.0, 62.0, 64.0], "value": 63.7, "unit": "score"}]}]} 02:30:40 INFO - Return code: 0 02:30:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:30:40 ERROR - # TBPL SUCCESS # 02:30:40 INFO - Running post-action listener: _resource_record_post_action 02:30:40 INFO - ##### 02:30:40 INFO - ##### Finished run-tests step (success) 02:30:40 INFO - ##### 02:30:40 INFO - Running post-run listener: _resource_record_post_run 02:30:40 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540983296; Read time: 16; Write time: 610260 02:30:40 INFO - TinderboxPrint: CPU usage
13.4% 02:30:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:30:40 INFO - TinderboxPrint: I/O write bytes / time
540,983,296 / 610,260 02:30:40 INFO - TinderboxPrint: CPU idle
8,232.4 (86.6%) 02:30:40 INFO - TinderboxPrint: CPU user
1,221.9 (12.8%) 02:30:40 INFO - TinderboxPrint: Swap in / out
0 / 0 02:30:40 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 213319680; Read time: 0; Write time: 306452 02:30:40 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292265984; Read time: 16; Write time: 292124 02:30:40 INFO - Running post-run listener: _upload_blobber_files 02:30:40 INFO - Blob upload gear active. 02:30:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:30:40 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 02:30:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:30:41 INFO - (blobuploader) - INFO - Open directory for files ... 02:30:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:30:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:30:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:41 INFO - (blobuploader) - INFO - Done attempting. 02:30:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:30:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:30:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:42 INFO - (blobuploader) - INFO - Done attempting. 02:30:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:30:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:30:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:46 INFO - (blobuploader) - INFO - Done attempting. 02:30:46 INFO - (blobuploader) - INFO - Iteration through files over. 02:30:46 INFO - Return code: 0 02:30:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:30:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:30:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08f8a599f3124869e0ee5fff45f53e06929c8876899a125588ccc8363fba991a2d8d9f9a32d5e4e91c575312ebc56f8c2702a79befc91d16a15aebdcb0bdb926", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1903311e2cd93c0f1157ed6b8604dbd727d95ff596008e432001379f5fbe1fd00203a45ed4d5dce9d3c19410b0fa4d9a6845dde5a5ee5fa9fa1b17c420490399", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13be96e08d7d4a4bfd08346a3e80f0ffc200e991d288d7d70b652bbdfc8636df0bf2218ba761ff059767adfa144b64b4251179a28543265b3abc477dadb1cec5"} 02:30:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:30:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:30:46 INFO - Contents: 02:30:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08f8a599f3124869e0ee5fff45f53e06929c8876899a125588ccc8363fba991a2d8d9f9a32d5e4e91c575312ebc56f8c2702a79befc91d16a15aebdcb0bdb926", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1903311e2cd93c0f1157ed6b8604dbd727d95ff596008e432001379f5fbe1fd00203a45ed4d5dce9d3c19410b0fa4d9a6845dde5a5ee5fa9fa1b17c420490399", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13be96e08d7d4a4bfd08346a3e80f0ffc200e991d288d7d70b652bbdfc8636df0bf2218ba761ff059767adfa144b64b4251179a28543265b3abc477dadb1cec5"} 02:30:46 INFO - Running post-run listener: copy_logs_to_upload_dir 02:30:46 INFO - Copying logs to upload dir... 02:30:46 INFO - mkdir: /builds/slave/test/build/upload/logs 02:30:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.026262 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-09 02:30:46.285159) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 02:30:46.289010) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819 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/sha512/08f8a599f3124869e0ee5fff45f53e06929c8876899a125588ccc8363fba991a2d8d9f9a32d5e4e91c575312ebc56f8c2702a79befc91d16a15aebdcb0bdb926", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1903311e2cd93c0f1157ed6b8604dbd727d95ff596008e432001379f5fbe1fd00203a45ed4d5dce9d3c19410b0fa4d9a6845dde5a5ee5fa9fa1b17c420490399", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13be96e08d7d4a4bfd08346a3e80f0ffc200e991d288d7d70b652bbdfc8636df0bf2218ba761ff059767adfa144b64b4251179a28543265b3abc477dadb1cec5"} build_url:https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/ZiIJbCmkRTGMLqcAhdq3TA/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/sha512/08f8a599f3124869e0ee5fff45f53e06929c8876899a125588ccc8363fba991a2d8d9f9a32d5e4e91c575312ebc56f8c2702a79befc91d16a15aebdcb0bdb926", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1903311e2cd93c0f1157ed6b8604dbd727d95ff596008e432001379f5fbe1fd00203a45ed4d5dce9d3c19410b0fa4d9a6845dde5a5ee5fa9fa1b17c420490399", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13be96e08d7d4a4bfd08346a3e80f0ffc200e991d288d7d70b652bbdfc8636df0bf2218ba761ff059767adfa144b64b4251179a28543265b3abc477dadb1cec5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 02:30:46.318058) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:30:46.318384) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465463406.376266-402262819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 02:30:46.404259) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 02:30:46.404613) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 02:30:46.404943) ========= ========= Total master_lag: 0.18 =========