builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1465226598.46 results: success (0) buildid: 20160606064128 builduid: ff14b9b295f3439e8b8d83158506ef80 revision: 4915ce29449ef3595957114ecdff8d036b72f238 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 08:23:18.462948) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 08:23:18.463563) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 08:23:18.463851) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 08:23:18.479018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 08:23:18.479301) ========= 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=4300f881736b422476174874000001bc-1465226577.692756-1766208441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 08:23:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-06-06 08:23:18 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119865 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 08:23:18.705142) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 08:23:18.705409) ========= 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=4300f881736b422476174874000001bc-1465226577.692756-1766208441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017027 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 08:23:18.735801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 08:23:18.736149) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4915ce29449ef3595957114ecdff8d036b72f238 --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 4915ce29449ef3595957114ecdff8d036b72f238 --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=4300f881736b422476174874000001bc-1465226577.692756-1766208441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 08:23:18,907 truncating revision to first 12 chars 2016-06-06 08:23:18,908 Setting DEBUG logging. 2016-06-06 08:23:18,908 attempt 1/10 2016-06-06 08:23:18,908 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4915ce29449e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 08:23:19,756 unpacking tar archive at: fx-team-4915ce29449e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.183247 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 08:23:19.933511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 08:23:19.933822) ========= script_repo_revision: 4915ce29449ef3595957114ecdff8d036b72f238 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 08:23:19.934209) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 08:23:19.934471) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 08:23:19.942347) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-06 08:23:19.942665) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1465226577.692756-1766208441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:23:20 INFO - MultiFileLogger online at 20160606 08:23:20 in /builds/slave/test 08:23:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:23:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:23:20 INFO - {'append_to_log': False, 08:23:20 INFO - 'base_work_dir': '/builds/slave/test', 08:23:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:23:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:23:20 INFO - 'branch': 'Fx-Team-Non-PGO', 08:23:20 INFO - 'buildbot_json_path': 'buildprops.json', 08:23:20 INFO - 'config_files': ('talos/linux_config.py',), 08:23:20 INFO - 'default_actions': ('clobber', 08:23:20 INFO - 'read-buildbot-config', 08:23:20 INFO - 'download-and-extract', 08:23:20 INFO - 'populate-webroot', 08:23:20 INFO - 'create-virtualenv', 08:23:20 INFO - 'install', 08:23:20 INFO - 'run-tests'), 08:23:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:23:20 INFO - 'download_minidump_stackwalk': True, 08:23:20 INFO - 'download_symbols': 'ondemand', 08:23:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:23:20 INFO - 'tooltool.py': '/tools/tooltool.py', 08:23:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:23:20 INFO - '/tools/misc-python/virtualenv.py')}, 08:23:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:23:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:23:20 INFO - 'installer_path': 'installer.exe', 08:23:20 INFO - 'log_level': 'info', 08:23:20 INFO - 'log_name': 'talos', 08:23:20 INFO - 'log_to_console': True, 08:23:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:23:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:23:20 INFO - 'opt_config_files': (), 08:23:20 INFO - 'pip_index': False, 08:23:20 INFO - 'sps_profile': False, 08:23:20 INFO - 'sps_profile_interval': 0, 08:23:20 INFO - 'suite': 'dromaeojs-e10s', 08:23:20 INFO - 'system_bits': '32', 08:23:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:23:20 INFO - 'title': 'talos-linux64-ix-045', 08:23:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:23:20 INFO - 'use_talos_json': True, 08:23:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:23:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:23:20 INFO - 'work_dir': 'build'} 08:23:20 INFO - ##### 08:23:20 INFO - ##### Running clobber step. 08:23:20 INFO - ##### 08:23:20 INFO - Running pre-action listener: _resource_record_pre_action 08:23:20 INFO - Running main action method: clobber 08:23:20 INFO - rmtree: /builds/slave/test/build 08:23:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:23:20 INFO - Running post-action listener: _resource_record_post_action 08:23:20 INFO - ##### 08:23:20 INFO - ##### Finished clobber step (success) 08:23:20 INFO - ##### 08:23:20 INFO - ##### 08:23:20 INFO - ##### Running read-buildbot-config step. 08:23:20 INFO - ##### 08:23:20 INFO - Running pre-action listener: _resource_record_pre_action 08:23:20 INFO - Running main action method: read_buildbot_config 08:23:20 INFO - Using buildbot properties: 08:23:20 INFO - { 08:23:20 INFO - "project": "", 08:23:20 INFO - "product": "firefox", 08:23:20 INFO - "script_repo_revision": "production", 08:23:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:23:20 INFO - "repository": "", 08:23:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 08:23:20 INFO - "buildid": "20160606064128", 08:23:20 INFO - "pgo_build": "False", 08:23:20 INFO - "basedir": "/builds/slave/test", 08:23:20 INFO - "buildnumber": 1558, 08:23:20 INFO - "slavename": "talos-linux64-ix-045", 08:23:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:23:20 INFO - "platform": "ubuntu64_hw", 08:23:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:23:20 INFO - "branch": "fx-team", 08:23:20 INFO - "repo_path": "integration/fx-team", 08:23:20 INFO - "revision": "4915ce29449ef3595957114ecdff8d036b72f238", 08:23:20 INFO - "stage_platform": "linux64", 08:23:20 INFO - "builduid": "ff14b9b295f3439e8b8d83158506ef80", 08:23:20 INFO - "slavebuilddir": "test" 08:23:20 INFO - } 08:23:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:23:20 INFO - Running post-action listener: _resource_record_post_action 08:23:20 INFO - ##### 08:23:20 INFO - ##### Finished read-buildbot-config step (success) 08:23:20 INFO - ##### 08:23:20 INFO - ##### 08:23:20 INFO - ##### Running download-and-extract step. 08:23:20 INFO - ##### 08:23:20 INFO - Running pre-action listener: _resource_record_pre_action 08:23:20 INFO - Running main action method: download_and_extract 08:23:20 INFO - mkdir: /builds/slave/test/build/tests 08:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:20 INFO - https://queue.taskcluster.net/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:23:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:23:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:23:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:23:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:23:21 INFO - Downloaded 1361 bytes. 08:23:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:23:21 INFO - Using the following test package requirements: 08:23:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:23:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:23:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:23:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:21 INFO - u'jsshell-linux-x86_64.zip'], 08:23:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:23:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:23:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:23:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:23:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:23:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:23:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:21 INFO - https://queue.taskcluster.net/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:23:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:23:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:23:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:23:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:23:24 INFO - Downloaded 22870980 bytes. 08:23:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:23:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:23:25 INFO - Return code: 0 08:23:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:23: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')]} 08:23:25 INFO - https://queue.taskcluster.net/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:23:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:23:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:23:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:23:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:23:26 INFO - Downloaded 22870980 bytes. 08:23:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:23:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:23:28 INFO - Return code: 0 08:23: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')]} 08:23:28 INFO - https://queue.taskcluster.net/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:23:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:23:29 INFO - Downloaded 10833369 bytes. 08:23:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:23:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:23:30 INFO - Return code: 0 08:23: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')]} 08:23:30 INFO - https://queue.taskcluster.net/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:23:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:23:32 INFO - Downloaded 55201164 bytes. 08:23:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:32 INFO - mkdir: /builds/slave/test/properties 08:23:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:23:32 INFO - Writing to file /builds/slave/test/properties/build_url 08:23:32 INFO - Contents: 08:23:32 INFO - build_url:https://queue.taskcluster.net/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:33 INFO - Running post-action listener: _resource_record_post_action 08:23:33 INFO - Running post-action listener: set_extra_try_arguments 08:23:33 INFO - ##### 08:23:33 INFO - ##### Finished download-and-extract step (success) 08:23:33 INFO - ##### 08:23:33 INFO - ##### 08:23:33 INFO - ##### Running populate-webroot step. 08:23:33 INFO - ##### 08:23:33 INFO - Running pre-action listener: _resource_record_pre_action 08:23:33 INFO - Running main action method: populate_webroot 08:23:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:23:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:23:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:23:33 INFO - '--tppagecycles', 08:23:33 INFO - '7'], 08:23:33 INFO - 'tests': ['tsvgm']}}, 08:23:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:23:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:23:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:23:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:23:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:33 INFO - 'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:33 INFO - 'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['damp', 'tps']}, 08:23:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:33 INFO - 'tests': ['damp', 'tps']}, 08:23:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['dromaeo_dom']}, 08:23:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:23:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['a11yr', 08:23:33 INFO - 'ts_paint', 08:23:33 INFO - 'tpaint', 08:23:33 INFO - 'sessionrestore', 08:23:33 INFO - 'sessionrestore_no_auto_restore', 08:23:33 INFO - 'tabpaint']}, 08:23:33 INFO - 'other-e10s': {'tests': ['a11yr', 08:23:33 INFO - 'ts_paint', 08:23:33 INFO - 'tpaint', 08:23:33 INFO - 'sessionrestore', 08:23:33 INFO - 'sessionrestore_no_auto_restore', 08:23:33 INFO - 'tabpaint']}, 08:23:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:23:33 INFO - 'ts_paint', 08:23:33 INFO - 'tpaint', 08:23:33 INFO - 'sessionrestore', 08:23:33 INFO - 'sessionrestore_no_auto_restore', 08:23:33 INFO - 'tabpaint']}, 08:23:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:23:33 INFO - 'ts_paint', 08:23:33 INFO - 'tpaint', 08:23:33 INFO - 'sessionrestore', 08:23:33 INFO - 'sessionrestore_no_auto_restore', 08:23:33 INFO - 'tabpaint']}, 08:23:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['a11yr', 08:23:33 INFO - 'ts_paint', 08:23:33 INFO - 'tpaint', 08:23:33 INFO - 'sessionrestore', 08:23:33 INFO - 'sessionrestore_no_auto_restore', 08:23:33 INFO - 'tabpaint']}, 08:23:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['a11yr', 08:23:33 INFO - 'ts_paint', 08:23:33 INFO - 'tpaint', 08:23:33 INFO - 'sessionrestore', 08:23:33 INFO - 'sessionrestore_no_auto_restore', 08:23:33 INFO - 'tabpaint']}, 08:23:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['tsvgx', 08:23:33 INFO - 'tsvgr_opacity', 08:23:33 INFO - 'tart', 08:23:33 INFO - 'tscrollx', 08:23:33 INFO - 'cart']}, 08:23:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:23:33 INFO - 'tsvgr_opacity', 08:23:33 INFO - 'tart', 08:23:33 INFO - 'tscrollx', 08:23:33 INFO - 'cart']}, 08:23:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:33 INFO - 'talos_options': ['--disable-e10s'], 08:23:33 INFO - 'tests': ['tp5o']}, 08:23:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:33 INFO - 'tests': ['tp5o']}, 08:23:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:33 INFO - 'talos_options': ['--disable-e10s', 08:23:33 INFO - '--xperf_path', 08:23:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:33 INFO - 'tests': ['tp5n']}, 08:23:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:33 INFO - 'talos_options': ['--xperf_path', 08:23:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:33 INFO - 'tests': ['tp5n']}}, 08:23:33 INFO - 'talos.zip': {'path': '', 08:23:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:23:33 INFO - Running post-action listener: _resource_record_post_action 08:23:33 INFO - ##### 08:23:33 INFO - ##### Finished populate-webroot step (success) 08:23:33 INFO - ##### 08:23:33 INFO - ##### 08:23:33 INFO - ##### Running create-virtualenv step. 08:23:33 INFO - ##### 08:23:33 INFO - Running pre-action listener: _resource_record_pre_action 08:23:33 INFO - Running main action method: create_virtualenv 08:23:33 INFO - Creating virtualenv /builds/slave/test/build/venv 08:23:33 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 08:23:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:23:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:23:33 INFO - Using real prefix '/usr' 08:23:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:23:33 INFO - Installing distribute.............................................................................................................................................................................................done. 08:23:35 INFO - Installing pip.................done. 08:23:35 INFO - Return code: 0 08:23:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6e46984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b1c0>, '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 0x219c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219c550>, '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': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', '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 08:23:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:23:35 INFO - Using env: {'DISPLAY': ':0', 08:23:35 INFO - 'HOME': '/home/cltbld', 08:23:35 INFO - 'LANG': 'en_US.UTF-8', 08:23:35 INFO - 'LANGUAGE': 'en_US:en', 08:23:35 INFO - 'LOGNAME': 'cltbld', 08:23:35 INFO - 'MAIL': '/var/mail/cltbld', 08:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:35 INFO - 'MOZ_NO_REMOTE': '1', 08:23:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:35 INFO - 'NO_EM_RESTART': '1', 08:23:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:35 INFO - 'PWD': '/builds/slave/test', 08:23:35 INFO - 'SHELL': '/bin/bash', 08:23:35 INFO - 'SHLVL': '1', 08:23:35 INFO - 'TERM': 'linux', 08:23:35 INFO - 'TMOUT': '86400', 08:23:35 INFO - 'USER': 'cltbld', 08:23:35 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', 08:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:35 INFO - '_': '/tools/buildbot/bin/python'} 08:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:36 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 08:23:36 INFO - Cleaning up... 08:23:36 INFO - Return code: 0 08:23:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:36 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 0x7f6e46984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b1c0>, '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 0x219c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219c550>, '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': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', '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 08:23:36 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 08:23:36 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 08:23:36 INFO - Using env: {'DISPLAY': ':0', 08:23:36 INFO - 'HOME': '/home/cltbld', 08:23:36 INFO - 'LANG': 'en_US.UTF-8', 08:23:36 INFO - 'LANGUAGE': 'en_US:en', 08:23:36 INFO - 'LOGNAME': 'cltbld', 08:23:36 INFO - 'MAIL': '/var/mail/cltbld', 08:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:36 INFO - 'MOZ_NO_REMOTE': '1', 08:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:36 INFO - 'NO_EM_RESTART': '1', 08:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:36 INFO - 'PWD': '/builds/slave/test', 08:23:36 INFO - 'SHELL': '/bin/bash', 08:23:36 INFO - 'SHLVL': '1', 08:23:36 INFO - 'TERM': 'linux', 08:23:36 INFO - 'TMOUT': '86400', 08:23:36 INFO - 'USER': 'cltbld', 08:23:36 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', 08:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:36 INFO - '_': '/tools/buildbot/bin/python'} 08:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:36 INFO - Downloading/unpacking psutil>=3.1.1 08:23:36 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 08:23:36 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 08:23:36 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 08:23:36 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 08:23:36 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 08:23:36 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 08:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:23:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:38 INFO - Installing collected packages: psutil 08:23:38 INFO - Running setup.py install for psutil 08:23:38 INFO - building 'psutil._psutil_linux' extension 08:23:38 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 08:23:38 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 08:23:38 INFO - building 'psutil._psutil_posix' extension 08:23:38 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 08:23:38 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 08:23:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:38 INFO - Successfully installed psutil 08:23:38 INFO - Cleaning up... 08:23:38 INFO - Return code: 0 08:23:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6e46984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b1c0>, '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 0x219c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219c550>, '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': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', '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 08:23:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:23:38 INFO - Using env: {'DISPLAY': ':0', 08:23:38 INFO - 'HOME': '/home/cltbld', 08:23:38 INFO - 'LANG': 'en_US.UTF-8', 08:23:38 INFO - 'LANGUAGE': 'en_US:en', 08:23:38 INFO - 'LOGNAME': 'cltbld', 08:23:38 INFO - 'MAIL': '/var/mail/cltbld', 08:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:38 INFO - 'MOZ_NO_REMOTE': '1', 08:23:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:38 INFO - 'NO_EM_RESTART': '1', 08:23:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:38 INFO - 'PWD': '/builds/slave/test', 08:23:38 INFO - 'SHELL': '/bin/bash', 08:23:38 INFO - 'SHLVL': '1', 08:23:38 INFO - 'TERM': 'linux', 08:23:38 INFO - 'TMOUT': '86400', 08:23:38 INFO - 'USER': 'cltbld', 08:23:38 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', 08:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:38 INFO - '_': '/tools/buildbot/bin/python'} 08:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:23:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:23:40 INFO - Installing collected packages: mozsystemmonitor 08:23:40 INFO - Running setup.py install for mozsystemmonitor 08:23:40 INFO - Successfully installed mozsystemmonitor 08:23:40 INFO - Cleaning up... 08:23:41 INFO - Return code: 0 08:23:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:41 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 0x7f6e46984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b1c0>, '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 0x219c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219c550>, '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': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', '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 08:23:41 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 08:23:41 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 08:23:41 INFO - Using env: {'DISPLAY': ':0', 08:23:41 INFO - 'HOME': '/home/cltbld', 08:23:41 INFO - 'LANG': 'en_US.UTF-8', 08:23:41 INFO - 'LANGUAGE': 'en_US:en', 08:23:41 INFO - 'LOGNAME': 'cltbld', 08:23:41 INFO - 'MAIL': '/var/mail/cltbld', 08:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:41 INFO - 'MOZ_NO_REMOTE': '1', 08:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:41 INFO - 'NO_EM_RESTART': '1', 08:23:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:41 INFO - 'PWD': '/builds/slave/test', 08:23:41 INFO - 'SHELL': '/bin/bash', 08:23:41 INFO - 'SHLVL': '1', 08:23:41 INFO - 'TERM': 'linux', 08:23:41 INFO - 'TMOUT': '86400', 08:23:41 INFO - 'USER': 'cltbld', 08:23:41 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', 08:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:41 INFO - '_': '/tools/buildbot/bin/python'} 08:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:41 INFO - Downloading/unpacking jsonschema==2.5.1 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:23:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:23:43 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 08:23:43 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 08:23:43 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 08:23:43 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 08:23:43 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 08:23:43 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 08:23:43 INFO - Downloading functools32-3.2.3-2.tar.gz 08:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:23:43 INFO - warning: no files found matching '*.txt' 08:23:43 INFO - no previously-included directories found matching 'build' 08:23:43 INFO - no previously-included directories found matching 'dist' 08:23:43 INFO - no previously-included directories found matching '.git*' 08:23:43 INFO - Installing collected packages: jsonschema, functools32 08:23:43 INFO - Running setup.py install for functools32 08:23:43 INFO - warning: no files found matching '*.txt' 08:23:43 INFO - no previously-included directories found matching 'build' 08:23:43 INFO - no previously-included directories found matching 'dist' 08:23:43 INFO - no previously-included directories found matching '.git*' 08:23:43 INFO - Successfully installed jsonschema functools32 08:23:43 INFO - Cleaning up... 08:23:43 INFO - Return code: 0 08:23:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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', '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 0x7f6e46984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b1c0>, '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 0x219c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219c550>, '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': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', '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 08:23: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:23: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 blobuploader==1.2.4 08:23:43 INFO - Using env: {'DISPLAY': ':0', 08:23:43 INFO - 'HOME': '/home/cltbld', 08:23:43 INFO - 'LANG': 'en_US.UTF-8', 08:23:43 INFO - 'LANGUAGE': 'en_US:en', 08:23:43 INFO - 'LOGNAME': 'cltbld', 08:23:43 INFO - 'MAIL': '/var/mail/cltbld', 08:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:43 INFO - 'MOZ_NO_REMOTE': '1', 08:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:43 INFO - 'NO_EM_RESTART': '1', 08:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:43 INFO - 'PWD': '/builds/slave/test', 08:23:43 INFO - 'SHELL': '/bin/bash', 08:23:43 INFO - 'SHLVL': '1', 08:23:43 INFO - 'TERM': 'linux', 08:23:43 INFO - 'TMOUT': '86400', 08:23:43 INFO - 'USER': 'cltbld', 08:23:43 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', 08:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:43 INFO - '_': '/tools/buildbot/bin/python'} 08:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:43 INFO - Downloading/unpacking blobuploader==1.2.4 08:23:43 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 08:23:43 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 08:23:43 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 08:23:43 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 08:23:43 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 08:23:43 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 08:23:45 INFO - Downloading blobuploader-1.2.4.tar.gz 08:23:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:23:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:23:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23:46 INFO - Downloading docopt-0.6.1.tar.gz 08:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:23:46 INFO - Installing collected packages: blobuploader, requests, docopt 08:23:46 INFO - Running setup.py install for blobuploader 08:23:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:23:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:23:46 INFO - Running setup.py install for requests 08:23:46 INFO - Running setup.py install for docopt 08:23:46 INFO - Successfully installed blobuploader requests docopt 08:23:46 INFO - Cleaning up... 08:23:47 INFO - Return code: 0 08:23:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:47 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 0x7f6e46984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b1c0>, '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 0x219c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219c550>, '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': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', '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 08:23:47 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 08:23:47 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 08:23:47 INFO - Using env: {'DISPLAY': ':0', 08:23:47 INFO - 'HOME': '/home/cltbld', 08:23:47 INFO - 'LANG': 'en_US.UTF-8', 08:23:47 INFO - 'LANGUAGE': 'en_US:en', 08:23:47 INFO - 'LOGNAME': 'cltbld', 08:23:47 INFO - 'MAIL': '/var/mail/cltbld', 08:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:47 INFO - 'MOZ_NO_REMOTE': '1', 08:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:47 INFO - 'NO_EM_RESTART': '1', 08:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:47 INFO - 'PWD': '/builds/slave/test', 08:23:47 INFO - 'SHELL': '/bin/bash', 08:23:47 INFO - 'SHLVL': '1', 08:23:47 INFO - 'TERM': 'linux', 08:23:47 INFO - 'TMOUT': '86400', 08:23:47 INFO - 'USER': 'cltbld', 08:23:47 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', 08:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:47 INFO - '_': '/tools/buildbot/bin/python'} 08:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:47 INFO - Running setup.py (path:/tmp/pip-H6xbTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:47 INFO - Running setup.py (path:/tmp/pip-9gp07v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:47 INFO - Running setup.py (path:/tmp/pip-YxoQJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:47 INFO - Running setup.py (path:/tmp/pip-cUnLgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:47 INFO - Running setup.py (path:/tmp/pip-yP2Gr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:47 INFO - Running setup.py (path:/tmp/pip-hHJKa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:47 INFO - Running setup.py (path:/tmp/pip-Yct51e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:47 INFO - Running setup.py (path:/tmp/pip-M3f82g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:47 INFO - Running setup.py (path:/tmp/pip-ie30TQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:47 INFO - Running setup.py (path:/tmp/pip-SvdkuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:47 INFO - Running setup.py (path:/tmp/pip-kHO5O0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:48 INFO - Running setup.py (path:/tmp/pip-IYZUKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:48 INFO - Running setup.py (path:/tmp/pip-0SImkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:48 INFO - Running setup.py (path:/tmp/pip-_aoS8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:48 INFO - Running setup.py (path:/tmp/pip-K29kAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:48 INFO - Running setup.py (path:/tmp/pip-cnu1TS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:48 INFO - Running setup.py (path:/tmp/pip-V50Y0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:23:48 INFO - Running setup.py install for manifestparser 08:23:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:23:48 INFO - Running setup.py install for mozcrash 08:23:48 INFO - Running setup.py install for mozdebug 08:23:48 INFO - Running setup.py install for mozdevice 08:23:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:23:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:23:48 INFO - Running setup.py install for mozfile 08:23:48 INFO - Running setup.py install for mozhttpd 08:23:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:23:49 INFO - Running setup.py install for mozinfo 08:23:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:23:49 INFO - Running setup.py install for mozInstall 08:23:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:23:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:23:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:23:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:23:49 INFO - Running setup.py install for mozleak 08:23:49 INFO - Running setup.py install for mozlog 08:23:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:23:49 INFO - Running setup.py install for moznetwork 08:23:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:23:49 INFO - Running setup.py install for mozprocess 08:23:49 INFO - Running setup.py install for mozprofile 08:23:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:23:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:23:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:23:49 INFO - Running setup.py install for mozrunner 08:23:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:23:49 INFO - Running setup.py install for mozscreenshot 08:23:50 INFO - Running setup.py install for moztest 08:23:50 INFO - Running setup.py install for mozversion 08:23:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:23:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:23:50 INFO - Cleaning up... 08:23:50 INFO - Return code: 0 08:23:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:50 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')]} 08:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:50 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')]} 08:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:50 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 0x7f6e46984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b1c0>, '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 0x219c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219c550>, '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': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', '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 08:23:50 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 08:23:50 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 08:23:50 INFO - Using env: {'DISPLAY': ':0', 08:23:50 INFO - 'HOME': '/home/cltbld', 08:23:50 INFO - 'LANG': 'en_US.UTF-8', 08:23:50 INFO - 'LANGUAGE': 'en_US:en', 08:23:50 INFO - 'LOGNAME': 'cltbld', 08:23:50 INFO - 'MAIL': '/var/mail/cltbld', 08:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:50 INFO - 'MOZ_NO_REMOTE': '1', 08:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:50 INFO - 'NO_EM_RESTART': '1', 08:23:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:50 INFO - 'PWD': '/builds/slave/test', 08:23:50 INFO - 'SHELL': '/bin/bash', 08:23:50 INFO - 'SHLVL': '1', 08:23:50 INFO - 'TERM': 'linux', 08:23:50 INFO - 'TMOUT': '86400', 08:23:50 INFO - 'USER': 'cltbld', 08:23:50 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', 08:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:50 INFO - '_': '/tools/buildbot/bin/python'} 08:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:50 INFO - Running setup.py (path:/tmp/pip-pxBK3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:50 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)) 08:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:50 INFO - Running setup.py (path:/tmp/pip-sdvU5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:50 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)) 08:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:50 INFO - Running setup.py (path:/tmp/pip-gTR95M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:50 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)) 08:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:50 INFO - Running setup.py (path:/tmp/pip-khn_Hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:50 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)) 08:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:50 INFO - Running setup.py (path:/tmp/pip-neYeWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:50 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)) 08:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:50 INFO - Running setup.py (path:/tmp/pip-1cIDDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:50 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)) 08:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:50 INFO - Running setup.py (path:/tmp/pip-A7o1NE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:50 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)) 08:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:50 INFO - Running setup.py (path:/tmp/pip-Onx92b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:51 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)) 08:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:51 INFO - Running setup.py (path:/tmp/pip-JRQmw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:51 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)) 08:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:51 INFO - Running setup.py (path:/tmp/pip-fY6NA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:51 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)) 08:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:51 INFO - Running setup.py (path:/tmp/pip-iNEEs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:51 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)) 08:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:51 INFO - Running setup.py (path:/tmp/pip-cpEhFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:51 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)) 08:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:51 INFO - Running setup.py (path:/tmp/pip-NpP1y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:51 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)) 08:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:51 INFO - Running setup.py (path:/tmp/pip-XnBKaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:51 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)) 08:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:51 INFO - Running setup.py (path:/tmp/pip-LY5M1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:51 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)) 08:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:51 INFO - Running setup.py (path:/tmp/pip-OWigkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:51 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)) 08:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:51 INFO - Running setup.py (path:/tmp/pip-DoTWCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:51 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)) 08:23:51 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)) 08:23:51 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)) 08:23:51 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)) 08:23:51 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)) 08:23:51 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)) 08:23:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:53 INFO - Downloading blessings-1.6.tar.gz 08:23:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:23:53 INFO - Installing collected packages: blessings 08:23:53 INFO - Running setup.py install for blessings 08:23:53 INFO - Successfully installed blessings 08:23:53 INFO - Cleaning up... 08:23:53 INFO - Return code: 0 08:23:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:23:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:54 INFO - Reading from file tmpfile_stdout 08:23:54 INFO - Current package versions: 08:23:54 INFO - argparse == 1.2.1 08:23:54 INFO - blessings == 1.6 08:23:54 INFO - blobuploader == 1.2.4 08:23:54 INFO - docopt == 0.6.1 08:23:54 INFO - functools32 == 3.2.3-2 08:23:54 INFO - jsonschema == 2.5.1 08:23:54 INFO - manifestparser == 1.1 08:23:54 INFO - mozInstall == 1.12 08:23:54 INFO - mozcrash == 0.17 08:23:54 INFO - mozdebug == 0.1 08:23:54 INFO - mozdevice == 0.48 08:23:54 INFO - mozfile == 1.2 08:23:54 INFO - mozhttpd == 0.7 08:23:54 INFO - mozinfo == 0.9 08:23:54 INFO - mozleak == 0.1 08:23:54 INFO - mozlog == 3.2 08:23:54 INFO - moznetwork == 0.27 08:23:54 INFO - mozprocess == 0.22 08:23:54 INFO - mozprofile == 0.28 08:23:54 INFO - mozrunner == 6.11 08:23:54 INFO - mozscreenshot == 0.1 08:23:54 INFO - mozsystemmonitor == 0.3 08:23:54 INFO - moztest == 0.7 08:23:54 INFO - mozversion == 1.4 08:23:54 INFO - psutil == 3.1.1 08:23:54 INFO - requests == 1.2.3 08:23:54 INFO - wsgiref == 0.1.2 08:23:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:54 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 0x7f6e46984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b1c0>, '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 0x219c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219c550>, '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': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', '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 08:23:54 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 08:23:54 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 08:23:54 INFO - Using env: {'DISPLAY': ':0', 08:23:54 INFO - 'HOME': '/home/cltbld', 08:23:54 INFO - 'LANG': 'en_US.UTF-8', 08:23:54 INFO - 'LANGUAGE': 'en_US:en', 08:23:54 INFO - 'LOGNAME': 'cltbld', 08:23:54 INFO - 'MAIL': '/var/mail/cltbld', 08:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:54 INFO - 'MOZ_NO_REMOTE': '1', 08:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:54 INFO - 'NO_EM_RESTART': '1', 08:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:54 INFO - 'PWD': '/builds/slave/test', 08:23:54 INFO - 'SHELL': '/bin/bash', 08:23:54 INFO - 'SHLVL': '1', 08:23:54 INFO - 'TERM': 'linux', 08:23:54 INFO - 'TMOUT': '86400', 08:23:54 INFO - 'USER': 'cltbld', 08:23:54 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', 08:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:54 INFO - '_': '/tools/buildbot/bin/python'} 08:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:54 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)) 08:23:54 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)) 08:23:54 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)) 08:23:54 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)) 08:23:54 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)) 08:23:54 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)) 08:23:54 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)) 08:23:54 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)) 08:23:54 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)) 08:23:54 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)) 08:23:54 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)) 08:23:54 INFO - Cleaning up... 08:23:54 INFO - Return code: 0 08:23:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6e46984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b1c0>, '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 0x219c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219c550>, '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': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', '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 08:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:23:54 INFO - Using env: {'DISPLAY': ':0', 08:23:54 INFO - 'HOME': '/home/cltbld', 08:23:54 INFO - 'LANG': 'en_US.UTF-8', 08:23:54 INFO - 'LANGUAGE': 'en_US:en', 08:23:54 INFO - 'LOGNAME': 'cltbld', 08:23:54 INFO - 'MAIL': '/var/mail/cltbld', 08:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:54 INFO - 'MOZ_NO_REMOTE': '1', 08:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:54 INFO - 'NO_EM_RESTART': '1', 08:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:54 INFO - 'PWD': '/builds/slave/test', 08:23:54 INFO - 'SHELL': '/bin/bash', 08:23:54 INFO - 'SHLVL': '1', 08:23:54 INFO - 'TERM': 'linux', 08:23:54 INFO - 'TMOUT': '86400', 08:23:54 INFO - 'USER': 'cltbld', 08:23:54 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', 08:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:54 INFO - '_': '/tools/buildbot/bin/python'} 08:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:23:54 INFO - Cleaning up... 08:23:54 INFO - Return code: 0 08:23:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6e46984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219b1c0>, '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 0x219c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219c550>, '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': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', '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 08:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:23:54 INFO - Using env: {'DISPLAY': ':0', 08:23:54 INFO - 'HOME': '/home/cltbld', 08:23:54 INFO - 'LANG': 'en_US.UTF-8', 08:23:54 INFO - 'LANGUAGE': 'en_US:en', 08:23:54 INFO - 'LOGNAME': 'cltbld', 08:23:54 INFO - 'MAIL': '/var/mail/cltbld', 08:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:54 INFO - 'MOZ_NO_REMOTE': '1', 08:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:54 INFO - 'NO_EM_RESTART': '1', 08:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:54 INFO - 'PWD': '/builds/slave/test', 08:23:54 INFO - 'SHELL': '/bin/bash', 08:23:54 INFO - 'SHLVL': '1', 08:23:54 INFO - 'TERM': 'linux', 08:23:54 INFO - 'TMOUT': '86400', 08:23:54 INFO - 'USER': 'cltbld', 08:23:54 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', 08:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:54 INFO - '_': '/tools/buildbot/bin/python'} 08:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:54 INFO - Downloading/unpacking flake8 08:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:23:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:23:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:23:57 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 08:23:57 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 08:23:57 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 08:23:57 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 08:23:57 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 08:23:57 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 08:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:23:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:23:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:23:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:23:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:23:57 INFO - no previously-included directories found matching 'docs/_build' 08:23:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:23:57 INFO - Running setup.py install for pep8 08:23:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:23:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:23:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:23:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:23:57 INFO - no previously-included directories found matching 'docs/_build' 08:23:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:23:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:23:57 INFO - Cleaning up... 08:23:57 INFO - Return code: 0 08:23:57 INFO - Running post-action listener: _resource_record_post_action 08:23:57 INFO - Running post-action listener: _start_resource_monitoring 08:23:57 INFO - Starting resource monitoring. 08:23:57 INFO - ##### 08:23:57 INFO - ##### Finished create-virtualenv step (success) 08:23:57 INFO - ##### 08:23:57 INFO - ##### 08:23:57 INFO - ##### Running install step. 08:23:57 INFO - ##### 08:23:57 INFO - Running pre-action listener: _resource_record_pre_action 08:23:57 INFO - Running main action method: install 08:23:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:57 INFO - Reading from file tmpfile_stdout 08:23:57 INFO - Detecting whether we're running mozinstall >=1.0... 08:23:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:23:57 INFO - Reading from file tmpfile_stdout 08:23:57 INFO - Output received: 08:23:57 INFO - Usage: mozinstall [options] installer 08:23:57 INFO - Options: 08:23:57 INFO - -h, --help show this help message and exit 08:23:57 INFO - -d DEST, --destination=DEST 08:23:57 INFO - Directory to install application into. [default: 08:23:57 INFO - "/builds/slave/test"] 08:23:57 INFO - --app=APP Application being installed. [default: firefox] 08:23:57 INFO - mkdir: /builds/slave/test/build/application 08:23:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:24:13 INFO - Reading from file tmpfile_stdout 08:24:13 INFO - Output received: 08:24:13 INFO - /builds/slave/test/build/application/firefox/firefox 08:24:13 INFO - Running post-action listener: _resource_record_post_action 08:24:13 INFO - ##### 08:24:13 INFO - ##### Finished install step (success) 08:24:13 INFO - ##### 08:24:13 INFO - ##### 08:24:13 INFO - ##### Running run-tests step. 08:24:13 INFO - ##### 08:24:13 INFO - Running pre-action listener: _resource_record_pre_action 08:24:13 INFO - Running main action method: run_tests 08:24:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:24:13 INFO - Python 2.7.3 08:24:13 INFO - Return code: 0 08:24:13 INFO - grabbing minidump binary from tooltool 08:24:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:13 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 0x219b1c0>, '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 0x219c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219c550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:24:13 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 08:24:13 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 08:24:13 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 08:24:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:24:13 INFO - Return code: 0 08:24:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:24:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:24:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:24:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:24:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:24:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:24:14 INFO - Return code: 0 08:24:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 08:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 08:24:14 INFO - Using env: {'DISPLAY': ':0', 08:24:14 INFO - 'HOME': '/home/cltbld', 08:24:14 INFO - 'LANG': 'en_US.UTF-8', 08:24:14 INFO - 'LANGUAGE': 'en_US:en', 08:24:14 INFO - 'LOGNAME': 'cltbld', 08:24:14 INFO - 'MAIL': '/var/mail/cltbld', 08:24:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:24:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:14 INFO - 'MOZ_NO_REMOTE': '1', 08:24:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:24:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:14 INFO - 'NO_EM_RESTART': '1', 08:24:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:14 INFO - 'PWD': '/builds/slave/test', 08:24:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:24:14 INFO - 'SHELL': '/bin/bash', 08:24:14 INFO - 'SHLVL': '1', 08:24:14 INFO - 'TERM': 'linux', 08:24:14 INFO - 'TMOUT': '86400', 08:24:14 INFO - 'USER': 'cltbld', 08:24:14 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465226577.692756-1766208441', 08:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:14 INFO - '_': '/tools/buildbot/bin/python'} 08:24:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 08:24:15 INFO - mozversion application_buildid: 20160606064128 08:24:15 INFO - mozversion application_changeset: 4915ce29449ef3595957114ecdff8d036b72f238 08:24:15 INFO - mozversion application_display_name: Nightly 08:24:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:24:15 INFO - mozversion application_name: Firefox 08:24:15 INFO - mozversion application_remotingname: firefox 08:24:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:24:15 INFO - mozversion application_vendor: Mozilla 08:24:15 INFO - mozversion application_version: 49.0a1 08:24:15 INFO - mozversion platform_buildid: 20160606064128 08:24:15 INFO - mozversion platform_changeset: 4915ce29449ef3595957114ecdff8d036b72f238 08:24:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:24:15 INFO - mozversion platform_version: 49.0a1 08:24:15 INFO - using testdate: 1465226655 08:24:15 INFO - actual date: 1465226655 08:24:15 INFO - starting webserver on 'localhost:39101' 08:24:15 INFO - SUITE-START | Running 2 tests 08:24:15 INFO - TEST-START | dromaeo_css 08:24:15 INFO - operating with platform_type : linux_ 08:24:15 INFO - Initialising browser for dromaeo_css test... 08:24:15 INFO - TEST-INFO | started process 28245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqBTo46/profile http://localhost:39101/getInfo.html) 08:24:20 INFO - PROCESS | 28245 | __metrics Screen width/height:1600/1200 08:24:20 INFO - PROCESS | 28245 | colorDepth:24 08:24:20 INFO - PROCESS | 28245 | Browser inner width/height: 1024/697 08:24:20 INFO - PROCESS | 28245 | __metrics 08:24:20 ERROR - PROCESS | 28245 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 08:24:21 INFO - TEST-INFO | 28245: exit 0 08:24:21 INFO - Browser initialized. 08:24:21 INFO - Running cycle 1/1 for dromaeo_css test... 08:24:21 INFO - TEST-INFO | started process 28363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqBTo46/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:33 INFO - PROCESS | 28363 | RSS: Main: 168378368 08:24:33 INFO - PROCESS | 28363 | 08:25:23 INFO - PROCESS | 28363 | 1465226723245 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] 08:27:34 INFO - PROCESS | 28363 | Cycle 1(1): loaded http://localhost:39101/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39101/tests/dromaeo/cssquery-ext.html) 08:27:36 INFO - PROCESS | 28363 | RSS: Main: 171380736 08:27:36 INFO - PROCESS | 28363 | 08:30:38 INFO - PROCESS | 28363 | Cycle 1(1): loaded http://localhost:39101/tests/dromaeo/cssquery-ext.html (next: http://localhost:39101/tests/dromaeo/cssquery-jquery.html) 08:30:38 INFO - PROCESS | 28363 | RSS: Main: 169828352 08:30:38 INFO - PROCESS | 28363 | 08:33:40 INFO - PROCESS | 28363 | Cycle 1(1): loaded http://localhost:39101/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39101/tests/dromaeo/cssquery-mootools.html) 08:33:41 INFO - PROCESS | 28363 | RSS: Main: 171401216 08:33:41 INFO - PROCESS | 28363 | 08:36:43 INFO - PROCESS | 28363 | Cycle 1(1): loaded http://localhost:39101/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39101/tests/dromaeo/cssquery-prototype.html) 08:36:43 INFO - PROCESS | 28363 | RSS: Main: 169267200 08:36:43 INFO - PROCESS | 28363 | 08:39:46 INFO - PROCESS | 28363 | Cycle 1(1): loaded http://localhost:39101/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39101/tests/dromaeo/cssquery-yui.html) 08:39:46 INFO - PROCESS | 28363 | RSS: Main: 171618304 08:39:46 INFO - PROCESS | 28363 | 08:42:49 INFO - PROCESS | 28363 | Cycle 1(1): loaded http://localhost:39101/tests/dromaeo/cssquery-yui.html (next: http://localhost:39101/tests/dromaeo/cssquery-dojo.html) 08:42:49 INFO - PROCESS | 28363 | RSS: Main: 172597248 08:42:49 INFO - PROCESS | 28363 | 08:42:49 INFO - PROCESS | 28363 | __start_tp_report 08:42:49 INFO - PROCESS | 28363 | _x_x_mozilla_page_load 08:42:49 INFO - PROCESS | 28363 | _x_x_mozilla_page_load_details 08:42:49 INFO - PROCESS | 28363 | |i|pagename|runs| 08:42:49 INFO - PROCESS | 28363 | |0;dojo.html;2716.9049083282084;2755.035737491878;2758.613794068831;2761.682406523248;2773.3066733316673;4713.835015774449;4729.858104256873;4768.070226305872;4833.178359678855;4878;4735.928961065587;4839.854804355866;4856.271559266112;4868.221084626461;4891.021795640868;4424.070945101533;4465.732056076646;4519.728816271017;4551.408316918796;4585.839495617654;4224.112936283384;4500.392447019643;4510.887227819298;4572.497025327211;4574.130915126132;4341.544137865541;4350.456192975878;4356.956430435686;4446;4451.198784218839;4422.09347083847;4424.446944131983;4484.5291244419195;4490.371348011281;4509.503954564995;4416.425864637608;4429.534898835608;4451.9777401113115;4466.843660471868;4525.547445255481;4638.512956139624;4720.079584481027;4725.740084295362;4742.241241401359;4761.95238047622;5171.870703232412;5184.248283998837;5187;5196.6881987080515;5249.265102885599;5164.870878228075;5206.583473322125;5212.452692467275;5228.607854410896;5239.73801309933;4839.201531747292;4858.611311095175;4860.125177468054;4862.222044472867;4902.803887844482;5278.392984806719;5316.9202461963105;5321.574274058144;5328.17413300939;5347.946520534822;5023.447420783711;5077.822276220389;5100.387953445536;5111.693298402108;5112.488751124858;5054.49455054499;5179.766910489037;5185.844424667266;5215.817446389358;5228.006678731029;5047.066292735855;5110.412302585176;5116.897662046813;5122.871928201825;5130.12787826063;5080.568151707146;5097.61767867404;5099.847004589868;5150.793968241303;5178.482151784867;4180.205760905418;4307.655387568987;4327.1345730853955;4339.414179085783;4369.082492676574;3797.0886987123445;3799.2021675448464;3808.8286027128847;3832.425136229532;3844.2695887781233;4463.866084017484;4511.593956543861;4529.8641040768825;4543.727376357429;4577.8397756078375;5110.412302585176;5151.4333423323405;5169.483051694876;5192;5197.324347834758;4532.0709254602725;4534.206513860061;4554.521775213555;4579.7252164870215;4607.170709272296;4616.815327386934;4619.976900115478;4646.395968524071;4656.604188644003;4689.7655117244;4708.858734237979;4876.292937524039;4900.926486102782;4903.901921961469;4920.237363208708;5206.5314121729225;5211.166213405837;5212.582993360446;5232.869178270574;5244.5279924806955;4902.583280421204;4906.803727850989;4912.606991440748;4917.409910810726;4919.926201107058;5143.6399452037995;5164.9741751291;5187.403448603308;5197.870053248699;5206.427292997843;5216.165413533817;5263.2631431600375;5268.736563171749;5275.366955965309;5339.546138578109;4819.807207711652;4919.3358896549935;5106.846794596168;5107.719075450886;5117.437081920912;4926.679765815211;4958.603311734981;4977.8257760978195;4982.551570358685;5025.020121076355;4868.61051115917;4884.5603895649565;4898.583620392164;4898.7550622468025;4943.0361079590575;4837.95162048375;4999.075171093359;5037;5063.493650634907;5075.568576671024;4974.676646017997;4982.053409852117;4998.550130488128;5006.274090256965;5048.368953880765 08:42:49 INFO - PROCESS | 28363 | |1;ext.html;526.5475445549145;578.997105014475;582.283790937147;601.9849503762404;615.5414216408776;35315.64684353159;38995;39100.80449597755;39130.804345978264;39191.21617567654;37045.44431833525;37207.06982325443;37311;37628.247435051286;37662.435063474004;7497.5876326802145;7599.050118735158;7642.388608911274;7668.654910529011;7668.65491052904;7748.147703752583;7876.684932602689;7879.527228366288;7894.921050789505;7898.723544675938;7823.2567906048835;7880.763577092696;7883.172266911978;7897.921020789805;7914.445988780788;7712.6914923403;7730.729424470116;7765.572893490856;7824.1002284737415;7868.6065696715505;7583.544987300779;7625.313721765067;7638.236176382373;7645.770626881203;7667.386609071261;37652;37856;37902.43146352807;37996.24007519862;38048.23903521942;3049.1767222849926;3309.586301712286;3419.452887538007;3585.6772890439725;3722.683571896392;28898.855505722546;29204.44203521987;29251.70748292511;30450.69549304523;30472.695273047208;3345.498175273704;3406.9659303406897;3435.7594968352223;3466.2027733621157;3591.515145455356;245885;247402;248140.9999999982;248699;248922;52910;53188.46811531835;53438.465615343346;53454.73272633612;53513.73243133837;33534;34338.141546461535;34376.65623343785;35520.223988800455;57674.423255767746;13480.191188528719;13535.187888726708;13572.728545429036;13581.592552223448;13591.728165436636;10235.078842904175;10246.590136394461;10251.077403033763;10266.435346056038;10269.281150319406;18546.44360669182;18552.165152568166;18670.53323666919;18767;18837.62324753497;6730.528862979544;6834.863302733917;6912.55068420551;7049.330313620198;7051.1891132519395;774.6243072110135;856.8243510080418;953.9983017831388;982.268210183418;1045.8901815309434;27816.860915695695;28713.71286287152;28730.425391492052;31961.840190798895;32040.519392209135;924.4822899176482;927.8840144981878;991.5934466868549;1030.1192480429124;1037.0044757033334;14695.412183512753;15015.924920375328;15086.245687715571;15378.84621153774;15458.922705386402;365047;369036;369773;369908;371430;50109.74945125324;50202.49797502051;50406.243906341435;50674;50783.74608126936;1203.48851738011;1243.055277988735;1255.8241846141548;1258.9307588082743;1262.8421447319085;27336.453270934868;28508.85745571259;28699.13902582926;28737.281567960967;28856.422871542873;43187.784061079496;44302.77848610736;44332.77833610812;44358.55641443544;44416.333754994346;324084;325798;326111;327455;327837;25434.364140896625;25669.791276090487;26214.34464138412;26234;26361.472770544096;42077.46039354402;42927.570724293604;42995;43398.56601433945;43875.56124438715;36933;36990.260194796494;37446.43830342602;37566.2486750258;37743.62256377511;36943.26113477769;37053.44419833651;37141.257174856895;37232.81383593065;37328.62671373251;30161.547576785928;35425.64574354327;35712.28575428529;35848.46227306645;36574.4513832298;31558.211044724067;33178.834105829315;33182.668173318925;33297.50053749147;33394.83302583569;24941.501169976134;25238.242852714448;25317.87341063283;25881.96472141093;25908.61137082983 08:42:49 INFO - PROCESS | 28363 | |2;jquery.html;352.28661959531945;354.36568542309266;357.69595843533;366.73228543163475;374.5636333671273;15686.921565392171;16659.25033373498;16769.24538395772;16933.83066169338;17129.657406851857;16009.838671779306;16725.494705476503;16957.66084678309;17052.658946821055;17070.14649267538;4902.3872015998;5074.847754567369;5095.745212739367;5105.081085404626;5117.769700363474;3785.0915780212827;4937.481564435737;5695.544356451494;5964.552658550626;5980.88038239235;5963.701814909237;5991.370906054867;6003.129546215796;6010.218671572711;6016;5712.6286791358425;5882.705864706748;5921.289445266552;5934.851628709295;5953.434423729739;4611.608013318872;5145.948540514584;5185.118529849935;5186.351706036746;5186.766595503212;11217.943910280397;11670.008049315818;11704.47329870158;11738.823917641157;11779.941100294443;1746.6943284925087;1839.5677015901254;1896.7439395681683;2103.2112957640884;2340.993372849674;8646.351523635689;8670.436421632574;8696.999845017841;8818.470891746452;9000.59497322622;1588.3011474950983;1602.1028224194488;1616.991915040429;1645.424101564443;1692.4668729350337;70557;71018.64490677514;71052;71928;72969;9337.486438245962;9392.248620110375;9521.428714277166;9588.232941364675;9743.171830394354;12974.221546707227;13032.087753857139;13033.934830325978;13042.804357934638;13082.738345233041;7200.603966781878;7213.603251821095;7236.457265704988;7312.926870731331;7340.779776606711;6991.475639327071;7011.789646310619;7021.789346319619;7127.92872071283;7146.892796608055;4048.4332193492933;4097.160082183145;4131.29767939451;4143.502779666459;4150.1284730207;1558.6648870492672;1655.2716804606175;1662.6924019056514;1738.8695847811464;1785.1877395784886;847.1316900177368;925.7037747920735;928.8374534456443;930.9162175404247;931.1991687149047;16258.918705406397;16596;17145.914270428817;17182;17253.39613113535;853.7182729699184;875.4397185801092;883.1389395339493;885.9291256699448;948.0188005414363;5164.690118592896;9563.952180239054;9617.182539484222;9630.807383852283;9768.12086912167;384113;393131;395073;396942;404045;71931.28068719245;74096.62951685207;79170;79880.60059699665;81866.59066704629;913.3789023463976;917.6100157433198;923.4597760310294;944.0229362609666;945.2485274207022;14339.283035848375;15063.623409414853;15237.161956092521;15379.077255364715;15428.537143885702;34612.82693586516;34683.30633387268;35976.82011589925;36114.27771444504;36456;46883.53116468928;48574;48757.756211218715;49070.75464622654;49559;6279;6554;6871.862562748817;7139.750108746169;7473.5426591814075;12061.216020958609;12197.451114699683;12203.450844712186;12349.62951111432;12370.62888113358;10367.222458315808;10446.738831529272;10586.788264234518;10700.678979630624;10790.514426850968;10502.10732087781;10666.946665266934;10673.94663026711;10727.141828653534;10740.087092597218;10690.41202733857;10753.408562529135;10789.244752867538;10793.08258798011;10878.744324144094;6854.246032936273;6854.3145685433055;6863.210730765826;6897.620630865351;7040.331168538981;9172.587233574639;9711.708648740549;9888.851667224853;10061.496925153859;10455.634052808115 08:42:49 INFO - PROCESS | 28363 | |3;mootools.html;1436.6480212347974;1450.5068276785894;1579.0762403993663;1756.6486702659472;1779.5195297269738;7012.158540975091;7549.509281896673;7733.342665873401;8278.875816862745;8289.626966786494;7627.580483073429;7742.070951485815;7828.099768526621;7865.567393793339;7890.56601886896;2190.5837890800776;2220.467087898901;2226.565819665166;2227.9777202228015;2236.1726161320335;2134.964542197033;2138.134055707441;2141.2077531313435;2141.4646338415396;2179.7384313882358;2138.647123224666;2139.775323591024;2145.3992881993067;2145.753238377591;2187.9671804922937;2104.9789502104936;2116.7036614873778;2120.204923153817;2120.5228823514817;2122.883241421737;2070.0581235537793;2088.832893368542;2105.620988222119;2120.4804822818355;2124.3945475539554;7801.141874393812;7829.608519574055;7885.960570197112;7903.762887113396;7912.920870791276;4601.194790911577;4668.813247470097;4709.222978208626;4729.26696362061;4758.976205118952;2804.4531316393313;2906.4913640112895;2914.446255211503;2915.096320140763;2926.6049083373687;821.6425854753202;872.2890843962214;874.3660845886745;892.6830975003845;893.5934149961752;11019.449027548591;11027.724306892393;11068.778624427547;11101.611443599435;11180.496877640526;4289.420928174719;4344.45694288214;4398.208322501916;4436.933445998313;4444.355568442557;9403.623855045858;9409.764755881159;9413.294002949806;9414.435133891851;9420.90579094214;4570.862874113782;4598.97700511502;4621.930671039937;4628.444586649556;4636.559526844944;3725.6274372562525;3931.5085614298214;4059.3099173140636;4193.266178418826;4222.831086756557;3694.946940122052;3723.0878434783654;3736.626337366296;3764.6235376462137;3816.2367526494813;1174.8237764335247;1217.8660347361783;1218.3360068762368;1225.6506895534908;1233.4326209943347;702.6873041496485;757.8257000889827;823.4976664234812;937.8452555328295;943.1087622196958;5535.280413546213;5607.45794906404;5616.1014237721765;5636.774529018793;5703.714814259353;836.2056046755606;878.5651102704202;942.8350038743192;945.9716208513755;953.5994882149375;3925.528936527635;3925.548561915359;3948.249832531867;3959.5050618672667;4008.7995600219874;9798.118169364792;10149.797004059878;10178.13485853696;10179.643712470028;10187.490625468845;9960.252981026451;9998.300118991601;10032.046955539212;10070.798584028278;10091.798164036678;7469.58917259556;7647.0441194851755;7677.424193185533;7677.731279405306;7695.653695583712;5517.475839795213;5745.74144163522;5749.166370876116;5758.2514273144225;5807.332156801853;9045;9260.583273752563;9267.490288034223;9288.58201380926;9299.209567186594;9095.363324567481;9247.86128208064;9299.349045566745;9314.906850931404;9536.141747242782;6623.6688165592495;6659.966700166468;6841.452683785385;6855.485838562227;6862;7648.923510765044;7655.425843061904;7660.2722741339485;7681.5775132366025;7712.460127791001;6785.321467853175;6917.9308206917285;7152.427805775629;7280.9271907280245;7295.23400043009;6974.37230649244;7023.069677503059;7051.365377116084;7064.32888875556;7132.358087772125;6586.967065164644;6694.665266736741;6718.93281067183;6719.697613607497;6735.259121496533;4592.219322715213;4602.217623004164;4926.451215207951;5049.823256186016;5056.039352523009;4984.2025275955675;5012.423571289202;5106.438291787826;5141.408737995179;5166.147585648326 08:42:49 INFO - PROCESS | 28363 | |4;prototype.html;287.5973636908328;289.5483046447542;293.2068754020375;293.5025132400581;294.22618513310016;4924.753762311883;4988.052270068684;5049.419316778572;5055.24171374294;5065.544101030907;4917.631177661672;4952.529509696582;4959.851204463863;4967.478414766451;4971.204607262839;3680.668739813423;3734.8319325630414;3805.2769973705044;3819;3862.613738626143;3840.923181536368;3855.556610989744;3877.418387241922;3891.3968334908136;3901.921961560767;3864.265789499986;3876.7286289959575;3878.9806050969705;3884.7863367514774;3887.786171760552;3795.2409518096492;3804.5624753153465;3860.498135242429;3872.883813485586;3881.1849511602595;3365.5288259643426;3369.2250782319957;3369.747268954838;3374.240795820945;3376.3416133853907;4803.255495398219;4811;4811.639127065449;4813.08551375241;4814.711117332936;4399.834043978349;4416.2713152329825;4433.645308375322;4454.354118652777;4457.420535330419;5049.697018178921;5178.171492561172;5201.609879259071;5206.921896171561;5273.789048438058;3683.834227459771;3705.4441833724886;3709.2766910452474;3731.6828069614116;3735.869244576454;5482;5531.778728850841;5540.889182216373;5543.307086614213;5548.557375082467;3590.605033446319;3809.0286976820735;3818.1409182933617;3825.6556909877686;3861.420786881934;3877.127646279621;3882.417637354363;3889.416587511896;3893.0267433141717;3897.9610203898164;4437.912711385731;4441.68908176431;4443.844465443694;4454.821807127743;4458.729262160269;4968.925466118011;5274.077036518594;5277.179373116269;5297.17893726473;5333.173358129496;1309.5416604188458;1323.5764555342391;1327.9668008299677;1330.8203392542077;1332.1074879830537;823.4482896459386;859.4027151129904;859.4542465534431;878.3763527895138;878.6836738774036;4560.589546940725;4614.123316569841;4619.330197121399;4638.165130276582;4657;5377.220303056035;5396.595255355785;5414.945850541523;5424.511793938565;5453.291072160594;4479.477361111761;4638.770725757677;4639.37368455261;4665.370175026328;4691.756684478616;2846.573014047868;2865.2550336912554;2871.196065101775;2873.252954231915;2897.2032691009717;5066.949330506648;5110.616703747234;5127.564157046618;5156.401515530198;5161;5297.231901374279;5563.276774019351;5590.608657394025;5599.608027438122;5655.501292157582;5154.407243167008;5178.896422071537;5186.196139598368;5187.377514698185;5195.74021298926;5456.345238571397;5485.6434331768305;5491.203775452457;5495.450454954473;5519.530839878495;5167.379914410295;5326.8934621308135;5372.838814835562;5375.193720941734;5393.191021346829;5116.155834287301;5122.769475373691;5124.2321399117245;5125.410577783454;5156.793728250828;3726.142987112925;3753.211825516672;3774.698024158116;3775.6030268799623;3794.108384529578;5370.194470829407;5439.292891924183;5445.264889239902;5457.536109430743;5554.916676249779;5261.237120617566;5295.232191332312;5302.3637163540625;5311.3891902431715;5320.840374788762;5287.7620507078045;5294.49702278283;5296.920546191887;5307.044731948132;5307.726145724921;4979.775910083982;5225.085610018307;5253.553447956967;5271.551918087006;5271.762770675406;5101.3113229715;5194;5329.893402132013;5331.653442526223;5347.786088556414;5203.505666961632;5208.166693329201;5212.348456442945;5219.321488206509;5220.321358223407 08:42:49 INFO - PROCESS | 28363 | |5;yui.html;647.6696884588861;667.5980441073746;711.7864640607818;712.6614857942475;730.6748496918871;12119.697007574816;12488.875111248884;12655;12658.683532911682;12682.3658817059;11828.526858925632;11903.64289071327;11967.46146423411;11968.700782480442;11973.341466219375;621.0994058615004;767.6238643064886;770.7957391291326;780.9219078092174;783.2324322164283;778.5289899610739;782.2763943352377;783.0994356490054;783.4476693930765;783.8667426537473;830.3689196210863;835.8161204534993;840.7603832907622;840.8276303357796;842.6671464771412;825.405707890318;828.8756686497013;829.6805729794013;830.8047608811925;833.7915521119751;603.0592276049377;607.1924340626956;608.2791891608458;610.2554883042725;611.10778263735;12374.319412432402;12379;12381.195222310522;12404.81392779109;12414.75170496594;13280.667983300495;13366.550803335733;13493.662658433519;13709;13787.379567919468;10087.798244035152;10124.898751012543;10221.182305415623;10318.535665894977;10504.894951050468;3340.231746698273;3343.2477692518987;3430.1939044324563;3436.329915666446;3461.826908654557;49577.75211123958;51928.74035629835;52024;57183.428165718644;57672.42327576713;9888.752781180385;10004;10243.282970192164;10312.484375781181;10382.273240873066;16220;16237.431689890796;16243.918780406022;16282.83717162837;17172.05553694534;7219.819504512429;7251.963740181371;7311.524750891175;7321.121465424183;7454.366378857858;3948.58539853317;4036.990752311922;4056.3104272273786;4067.8779636610357;4068.7355321904574;3012.487877060905;3114.034649258737;3120.8439578021007;3121.438141134572;3123.9219019524694;533.2001997004493;541.5910987204635;554.4372461951123;557.2115456628906;561.6489693941287;502.86171302891995;561.7303694226713;608.1091201389985;639.1467391033023;645.141961191614;8570.828583428296;8721.951122452589;8727.170918762835;8938.24024957886;9031.77420564478;514.2543312197329;591;594.7450878646054;621.810347843903;624.4536030972898;3684.9263014739554;3797.9050523736573;3800.051769109801;3887.047673319998;3951.0122469382654;89481.55259223662;90378;91083.54458227666;93567.53216233876;93933.5303323479;72329;77009.61495192489;77815.61092194503;78523.60738196272;79136.6043169792;68617.65691171613;68900.31099689039;69216;69630.65184674044;70040.89877303792;6958.895616565655;7226.891596625949;7894.565798881116;8271.793205169919;8350.03974542911;39522.80238598789;41144.79427602843;41323.96690082772;42139.578604213566;44005.55994440143;59319.06352511149;61624.383756161864;62740.68629656822;63039.36960630335;63319.6834015827;8995.280377569648;9001.234895033733;9097.954510227406;9152.58813353414;9397.812043759222;9637.469939153414;9690.806183876424;10091.041351071637;10282;10317.226208034577;9979.750506237402;10018.198544116307;10182.134518566005;10525;10594.046535811814;9550.283728720235;9793.314467987457;9878.30851840393;9920.900790992286;10039.4478303694;9751.609935602497;9892;9905.257105717244;9907.554160062959;9908.504574771378;7719.228077192236;7820.491668041559;7829.765107046797;7988.8002799928145;8407.201315874981;7101;7333.413326933725;7398.593077380796;7403.074615673041;7600.403915177874 08:42:49 INFO - PROCESS | 28363 | __end_tp_report 08:42:49 INFO - PROCESS | 28363 | __start_cc_report 08:42:49 INFO - PROCESS | 28363 | _x_x_mozilla_cycle_collect,381 08:42:49 INFO - PROCESS | 28363 | __end_cc_report 08:42:49 INFO - PROCESS | 28363 | __startTimestamp1465227769793__endTimestamp 08:42:49 INFO - PROCESS | 28363 | 08:42:49 INFO - PROCESS | 28363 | ------- Summary: start ------- 08:42:49 INFO - PROCESS | 28363 | Number of tests: 6 08:42:49 INFO - PROCESS | 28363 | 08:42:49 INFO - PROCESS | 28363 | [#0] dojo.html Cycles:165 Average:4782.64 Median:4900.93 stddev:497.19 (10.1%) stddev-sans-first:471.56 08:42:49 INFO - PROCESS | 28363 | Values: 2716.9 2755.0 2758.6 2761.7 2773.3 4713.8 4729.9 4768.1 4833.2 4878.0 4735.9 4839.9 4856.3 4868.2 4891.0 4424.1 4465.7 4519.7 4551.4 4585.8 4224.1 4500.4 4510.9 4572.5 4574.1 4341.5 4350.5 4357.0 4446.0 4451.2 4422.1 4424.4 4484.5 4490.4 4509.5 4416.4 4429.5 4452.0 4466.8 4525.5 4638.5 4720.1 4725.7 4742.2 4762.0 5171.9 5184.2 5187.0 5196.7 5249.3 5164.9 5206.6 5212.5 5228.6 5239.7 4839.2 4858.6 4860.1 4862.2 4902.8 5278.4 5316.9 5321.6 5328.2 5347.9 5023.4 5077.8 5100.4 5111.7 5112.5 5054.5 5179.8 5185.8 5215.8 5228.0 5047.1 5110.4 5116.9 5122.9 5130.1 5080.6 5097.6 5099.8 5150.8 5178.5 4180.2 4307.7 4327.1 4339.4 4369.1 3797.1 3799.2 3808.8 3832.4 3844.3 4463.9 4511.6 4529.9 4543.7 4577.8 5110.4 5151.4 5169.5 5192.0 5197.3 4532.1 4534.2 4554.5 4579.7 4607.2 4616.8 4620.0 4646.4 4656.6 4689.8 4708.9 4876.3 4900.9 4903.9 4920.2 5206.5 5211.2 5212.6 5232.9 5244.5 4902.6 4906.8 4912.6 4917.4 4919.9 5143.6 5165.0 5187.4 5197.9 5206.4 5216.2 5263.3 5268.7 5275.4 5339.5 4819.8 4919.3 5106.8 5107.7 5117.4 4926.7 4958.6 4977.8 4982.6 5025.0 4868.6 4884.6 4898.6 4898.8 4943.0 4838.0 4999.1 5037.0 5063.5 5075.6 4974.7 4982.1 4998.6 5006.3 5048.4 08:42:49 INFO - PROCESS | 28363 | 08:42:49 INFO - PROCESS | 28363 | [#1] ext.html Cycles:180 Average:46725.58 Median:203358.13 stddev:83695.52 (41.2%) stddev-sans-first:83858.43 08:42:49 INFO - PROCESS | 28363 | Values: 526.5 579.0 582.3 602.0 615.5 35315.6 38995.0 39100.8 39130.8 39191.2 37045.4 37207.1 37311.0 37628.2 37662.4 7497.6 7599.1 7642.4 7668.7 7668.7 7748.1 7876.7 7879.5 7894.9 7898.7 7823.3 7880.8 7883.2 7897.9 7914.4 7712.7 7730.7 7765.6 7824.1 7868.6 7583.5 7625.3 7638.2 7645.8 7667.4 37652.0 37856.0 37902.4 37996.2 38048.2 3049.2 3309.6 3419.5 3585.7 3722.7 28898.9 29204.4 29251.7 30450.7 30472.7 3345.5 3407.0 3435.8 3466.2 3591.5 245885.0 247402.0 248141.0 248699.0 248922.0 52910.0 53188.5 53438.5 53454.7 53513.7 33534.0 34338.1 34376.7 35520.2 57674.4 13480.2 13535.2 13572.7 13581.6 13591.7 10235.1 10246.6 10251.1 10266.4 10269.3 18546.4 18552.2 18670.5 18767.0 18837.6 6730.5 6834.9 6912.6 7049.3 7051.2 774.6 856.8 954.0 982.3 1045.9 27816.9 28713.7 28730.4 31961.8 32040.5 924.5 927.9 991.6 1030.1 1037.0 14695.4 15015.9 15086.2 15378.8 15458.9 365047.0 369036.0 369773.0 369908.0 371430.0 50109.7 50202.5 50406.2 50674.0 50783.7 1203.5 1243.1 1255.8 1258.9 1262.8 27336.5 28508.9 28699.1 28737.3 28856.4 43187.8 44302.8 44332.8 44358.6 44416.3 324084.0 325798.0 326111.0 327455.0 327837.0 25434.4 25669.8 26214.3 26234.0 26361.5 42077.5 42927.6 42995.0 43398.6 43875.6 36933.0 36990.3 37446.4 37566.2 37743.6 36943.3 37053.4 37141.3 37232.8 37328.6 30161.5 35425.6 35712.3 35848.5 36574.5 31558.2 33178.8 33182.7 33297.5 33394.8 24941.5 25238.2 25317.9 25882.0 25908.6 08:42:49 INFO - PROCESS | 28363 | 08:42:49 INFO - PROCESS | 28363 | [#2] jquery.html Cycles:180 Average:24075.87 Median:48665.88 stddev:65216.19 (134.0%) stddev-sans-first:65374.82 08:42:49 INFO - PROCESS | 28363 | Values: 352.3 354.4 357.7 366.7 374.6 15686.9 16659.3 16769.2 16933.8 17129.7 16009.8 16725.5 16957.7 17052.7 17070.1 4902.4 5074.8 5095.7 5105.1 5117.8 3785.1 4937.5 5695.5 5964.6 5980.9 5963.7 5991.4 6003.1 6010.2 6016.0 5712.6 5882.7 5921.3 5934.9 5953.4 4611.6 5145.9 5185.1 5186.4 5186.8 11217.9 11670.0 11704.5 11738.8 11779.9 1746.7 1839.6 1896.7 2103.2 2341.0 8646.4 8670.4 8697.0 8818.5 9000.6 1588.3 1602.1 1617.0 1645.4 1692.5 70557.0 71018.6 71052.0 71928.0 72969.0 9337.5 9392.2 9521.4 9588.2 9743.2 12974.2 13032.1 13033.9 13042.8 13082.7 7200.6 7213.6 7236.5 7312.9 7340.8 6991.5 7011.8 7021.8 7127.9 7146.9 4048.4 4097.2 4131.3 4143.5 4150.1 1558.7 1655.3 1662.7 1738.9 1785.2 847.1 925.7 928.8 930.9 931.2 16258.9 16596.0 17145.9 17182.0 17253.4 853.7 875.4 883.1 885.9 948.0 5164.7 9564.0 9617.2 9630.8 9768.1 384113.0 393131.0 395073.0 396942.0 404045.0 71931.3 74096.6 79170.0 79880.6 81866.6 913.4 917.6 923.5 944.0 945.2 14339.3 15063.6 15237.2 15379.1 15428.5 34612.8 34683.3 35976.8 36114.3 36456.0 46883.5 48574.0 48757.8 49070.8 49559.0 6279.0 6554.0 6871.9 7139.8 7473.5 12061.2 12197.5 12203.5 12349.6 12370.6 10367.2 10446.7 10586.8 10700.7 10790.5 10502.1 10666.9 10673.9 10727.1 10740.1 10690.4 10753.4 10789.2 10793.1 10878.7 6854.2 6854.3 6863.2 6897.6 7040.3 9172.6 9711.7 9888.9 10061.5 10455.6 08:42:49 INFO - PROCESS | 28363 | 08:42:49 INFO - PROCESS | 28363 | [#3] mootools.html Cycles:180 Average:5311.71 Median:5153.78 stddev:2993.25 (58.1%) stddev-sans-first:2987.49 08:42:49 INFO - PROCESS | 28363 | Values: 1436.6 1450.5 1579.1 1756.6 1779.5 7012.2 7549.5 7733.3 8278.9 8289.6 7627.6 7742.1 7828.1 7865.6 7890.6 2190.6 2220.5 2226.6 2228.0 2236.2 2135.0 2138.1 2141.2 2141.5 2179.7 2138.6 2139.8 2145.4 2145.8 2188.0 2105.0 2116.7 2120.2 2120.5 2122.9 2070.1 2088.8 2105.6 2120.5 2124.4 7801.1 7829.6 7886.0 7903.8 7912.9 4601.2 4668.8 4709.2 4729.3 4759.0 2804.5 2906.5 2914.4 2915.1 2926.6 821.6 872.3 874.4 892.7 893.6 11019.4 11027.7 11068.8 11101.6 11180.5 4289.4 4344.5 4398.2 4436.9 4444.4 9403.6 9409.8 9413.3 9414.4 9420.9 4570.9 4599.0 4621.9 4628.4 4636.6 3725.6 3931.5 4059.3 4193.3 4222.8 3694.9 3723.1 3736.6 3764.6 3816.2 1174.8 1217.9 1218.3 1225.7 1233.4 702.7 757.8 823.5 937.8 943.1 5535.3 5607.5 5616.1 5636.8 5703.7 836.2 878.6 942.8 946.0 953.6 3925.5 3925.5 3948.2 3959.5 4008.8 9798.1 10149.8 10178.1 10179.6 10187.5 9960.3 9998.3 10032.0 10070.8 10091.8 7469.6 7647.0 7677.4 7677.7 7695.7 5517.5 5745.7 5749.2 5758.3 5807.3 9045.0 9260.6 9267.5 9288.6 9299.2 9095.4 9247.9 9299.3 9314.9 9536.1 6623.7 6660.0 6841.5 6855.5 6862.0 7648.9 7655.4 7660.3 7681.6 7712.5 6785.3 6917.9 7152.4 7280.9 7295.2 6974.4 7023.1 7051.4 7064.3 7132.4 6587.0 6694.7 6718.9 6719.7 6735.3 4592.2 4602.2 4926.5 5049.8 5056.0 4984.2 5012.4 5106.4 5141.4 5166.1 08:42:49 INFO - PROCESS | 28363 | 08:42:49 INFO - PROCESS | 28363 | [#4] prototype.html Cycles:180 Average:4361.48 Median:4970.07 stddev:1288.31 (25.9%) stddev-sans-first:1255.11 08:42:49 INFO - PROCESS | 28363 | Values: 287.6 289.5 293.2 293.5 294.2 4924.8 4988.1 5049.4 5055.2 5065.5 4917.6 4952.5 4959.9 4967.5 4971.2 3680.7 3734.8 3805.3 3819.0 3862.6 3840.9 3855.6 3877.4 3891.4 3901.9 3864.3 3876.7 3879.0 3884.8 3887.8 3795.2 3804.6 3860.5 3872.9 3881.2 3365.5 3369.2 3369.7 3374.2 3376.3 4803.3 4811.0 4811.6 4813.1 4814.7 4399.8 4416.3 4433.6 4454.4 4457.4 5049.7 5178.2 5201.6 5206.9 5273.8 3683.8 3705.4 3709.3 3731.7 3735.9 5482.0 5531.8 5540.9 5543.3 5548.6 3590.6 3809.0 3818.1 3825.7 3861.4 3877.1 3882.4 3889.4 3893.0 3898.0 4437.9 4441.7 4443.8 4454.8 4458.7 4968.9 5274.1 5277.2 5297.2 5333.2 1309.5 1323.6 1328.0 1330.8 1332.1 823.4 859.4 859.5 878.4 878.7 4560.6 4614.1 4619.3 4638.2 4657.0 5377.2 5396.6 5414.9 5424.5 5453.3 4479.5 4638.8 4639.4 4665.4 4691.8 2846.6 2865.3 2871.2 2873.3 2897.2 5066.9 5110.6 5127.6 5156.4 5161.0 5297.2 5563.3 5590.6 5599.6 5655.5 5154.4 5178.9 5186.2 5187.4 5195.7 5456.3 5485.6 5491.2 5495.5 5519.5 5167.4 5326.9 5372.8 5375.2 5393.2 5116.2 5122.8 5124.2 5125.4 5156.8 3726.1 3753.2 3774.7 3775.6 3794.1 5370.2 5439.3 5445.3 5457.5 5554.9 5261.2 5295.2 5302.4 5311.4 5320.8 5287.8 5294.5 5296.9 5307.0 5307.7 4979.8 5225.1 5253.6 5271.6 5271.8 5101.3 5194.0 5329.9 5331.7 5347.8 5203.5 5208.2 5212.3 5219.3 5220.3 08:42:49 INFO - PROCESS | 28363 | 08:42:49 INFO - PROCESS | 28363 | [#5] yui.html Cycles:180 Average:16425.64 Median:621.45 stddev:23554.67 (3790.2%) stddev-sans-first:23590.95 08:42:49 INFO - PROCESS | 28363 | Values: 647.7 667.6 711.8 712.7 730.7 12119.7 12488.9 12655.0 12658.7 12682.4 11828.5 11903.6 11967.5 11968.7 11973.3 621.1 767.6 770.8 780.9 783.2 778.5 782.3 783.1 783.4 783.9 830.4 835.8 840.8 840.8 842.7 825.4 828.9 829.7 830.8 833.8 603.1 607.2 608.3 610.3 611.1 12374.3 12379.0 12381.2 12404.8 12414.8 13280.7 13366.6 13493.7 13709.0 13787.4 10087.8 10124.9 10221.2 10318.5 10504.9 3340.2 3343.2 3430.2 3436.3 3461.8 49577.8 51928.7 52024.0 57183.4 57672.4 9888.8 10004.0 10243.3 10312.5 10382.3 16220.0 16237.4 16243.9 16282.8 17172.1 7219.8 7252.0 7311.5 7321.1 7454.4 3948.6 4037.0 4056.3 4067.9 4068.7 3012.5 3114.0 3120.8 3121.4 3123.9 533.2 541.6 554.4 557.2 561.6 502.9 561.7 608.1 639.1 645.1 8570.8 8722.0 8727.2 8938.2 9031.8 514.3 591.0 594.7 621.8 624.5 3684.9 3797.9 3800.1 3887.0 3951.0 89481.6 90378.0 91083.5 93567.5 93933.5 72329.0 77009.6 77815.6 78523.6 79136.6 68617.7 68900.3 69216.0 69630.7 70040.9 6958.9 7226.9 7894.6 8271.8 8350.0 39522.8 41144.8 41324.0 42139.6 44005.6 59319.1 61624.4 62740.7 63039.4 63319.7 8995.3 9001.2 9098.0 9152.6 9397.8 9637.5 9690.8 10091.0 10282.0 10317.2 9979.8 10018.2 10182.1 10525.0 10594.0 9550.3 9793.3 9878.3 9920.9 10039.4 9751.6 9892.0 9905.3 9907.6 9908.5 7719.2 7820.5 7829.8 7988.8 8407.2 7101.0 7333.4 7398.6 7403.1 7600.4 08:42:49 INFO - PROCESS | 28363 | -------- Summary: end -------- 08:42:49 INFO - PROCESS | 28363 | 08:42:50 INFO - TEST-INFO | 28363: exit 0 08:42:50 INFO - TEST-OK | dromaeo_css | took 1115505ms 08:42:50 INFO - TEST-START | kraken 08:42:50 INFO - operating with platform_type : linux_ 08:42:50 INFO - Initialising browser for kraken test... 08:42:50 INFO - TEST-INFO | started process 28593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd4rJCm/profile http://localhost:39101/getInfo.html) 08:42:55 INFO - PROCESS | 28593 | __metrics Screen width/height:1600/1200 08:42:55 INFO - PROCESS | 28593 | colorDepth:24 08:42:55 INFO - PROCESS | 28593 | Browser inner width/height: 1024/697 08:42:55 INFO - PROCESS | 28593 | __metrics 08:42:56 ERROR - PROCESS | 28593 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 08:42:57 INFO - TEST-INFO | 28593: exit 0 08:42:57 INFO - Browser initialized. 08:42:57 INFO - Running cycle 1/1 for kraken test... 08:42:57 INFO - TEST-INFO | started process 28712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd4rJCm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:09 INFO - PROCESS | 28712 | RSS: Main: 168054784 08:43:09 INFO - PROCESS | 28712 | 08:43:11 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:39101/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39101/tests/kraken/driver.html?testName=audio-beat-detection) 08:43:12 INFO - PROCESS | 28712 | RSS: Main: 172441600 08:43:12 INFO - PROCESS | 28712 | 08:43:15 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:39101/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39101/tests/kraken/driver.html?testName=audio-dft) 08:43:16 INFO - PROCESS | 28712 | RSS: Main: 171966464 08:43:16 INFO - PROCESS | 28712 | 08:43:19 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:39101/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39101/tests/kraken/driver.html?testName=audio-fft) 08:43:19 INFO - PROCESS | 28712 | RSS: Main: 167415808 08:43:19 INFO - PROCESS | 28712 | 08:43:21 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:39101/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39101/tests/kraken/driver.html?testName=audio-oscillator) 08:43:22 INFO - PROCESS | 28712 | RSS: Main: 168062976 08:43:22 INFO - PROCESS | 28712 | 08:43:24 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:39101/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39101/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:43:25 INFO - PROCESS | 28712 | RSS: Main: 168296448 08:43:25 INFO - PROCESS | 28712 | 08:43:28 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:39101/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39101/tests/kraken/driver.html?testName=imaging-darkroom) 08:43:29 INFO - PROCESS | 28712 | RSS: Main: 168689664 08:43:29 INFO - PROCESS | 28712 | 08:43:32 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:39101/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39101/tests/kraken/driver.html?testName=imaging-desaturate) 08:43:33 INFO - PROCESS | 28712 | RSS: Main: 166547456 08:43:33 INFO - PROCESS | 28712 | 08:43:36 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:39101/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39101/tests/kraken/driver.html?testName=json-parse-financial) 08:43:36 INFO - PROCESS | 28712 | RSS: Main: 167596032 08:43:36 INFO - PROCESS | 28712 | 08:43:38 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:39101/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39101/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:43:39 INFO - PROCESS | 28712 | RSS: Main: 168255488 08:43:39 INFO - PROCESS | 28712 | 08:43:41 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:39101/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39101/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:43:41 INFO - PROCESS | 28712 | RSS: Main: 168304640 08:43:41 INFO - PROCESS | 28712 | 08:43:44 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:39101/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39101/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:43:44 INFO - PROCESS | 28712 | RSS: Main: 168906752 08:43:44 INFO - PROCESS | 28712 | 08:43:47 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:39101/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39101/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:43:48 INFO - PROCESS | 28712 | RSS: Main: 168845312 08:43:48 INFO - PROCESS | 28712 | 08:43:51 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:39101/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39101/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:43:51 INFO - PROCESS | 28712 | RSS: Main: 168292352 08:43:51 INFO - PROCESS | 28712 | 08:43:53 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:39101/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39101/tests/kraken/driver.html?testName=ai-astar) 08:43:53 INFO - PROCESS | 28712 | RSS: Main: 169439232 08:43:53 INFO - PROCESS | 28712 | 08:43:53 INFO - PROCESS | 28712 | __start_tp_report 08:43:53 INFO - PROCESS | 28712 | _x_x_mozilla_page_load 08:43:53 INFO - PROCESS | 28712 | _x_x_mozilla_page_load_details 08:43:53 INFO - PROCESS | 28712 | |i|pagename|runs| 08:43:53 INFO - PROCESS | 28712 | |0;ai-astar;116;109;113;113;115;114;113;113;115;115 08:43:53 INFO - PROCESS | 28712 | |1;audio-beat-detection;153;131;154;192;132;164;158;141;201;130 08:43:53 INFO - PROCESS | 28712 | |2;audio-dft;164;163;166;178;164;163;164;163;163;162 08:43:53 INFO - PROCESS | 28712 | |3;audio-fft;77;77;76;155;76;77;76;76;155;76 08:43:53 INFO - PROCESS | 28712 | |4;audio-oscillator;87;87;147;87;86;87;146;86;87;137 08:43:53 INFO - PROCESS | 28712 | |5;imaging-gaussian-blur;117;118;118;118;118;118;117;117;118;117 08:43:53 INFO - PROCESS | 28712 | |6;imaging-darkroom;148;147;155;148;146;146;148;150;150;147 08:43:53 INFO - PROCESS | 28712 | |7;imaging-desaturate;96;97;95;96;96;96;96;96;96;96 08:43:53 INFO - PROCESS | 28712 | |8;json-parse-financial;64;66;65;64;66;63;66;66;64;67 08:43:53 INFO - PROCESS | 28712 | |9;json-stringify-tinderbox;65;65;66;65;68;65;65;67;67;66 08:43:53 INFO - PROCESS | 28712 | |10;stanford-crypto-aes;82;84;83;89;84;84;91;86;114;90 08:43:53 INFO - PROCESS | 28712 | |11;stanford-crypto-ccm;135;147;134;133;146;135;137;147;139;139 08:43:53 INFO - PROCESS | 28712 | |12;stanford-crypto-pbkdf2;172;170;175;169;169;173;171;167;170;172 08:43:53 INFO - PROCESS | 28712 | |13;stanford-crypto-sha256-iterative;67;66;69;66;67;76;73;66;67;66 08:43:53 INFO - PROCESS | 28712 | __end_tp_report 08:43:53 INFO - PROCESS | 28712 | __start_cc_report 08:43:53 INFO - PROCESS | 28712 | _x_x_mozilla_cycle_collect,957 08:43:53 INFO - PROCESS | 28712 | __end_cc_report 08:43:53 INFO - PROCESS | 28712 | __startTimestamp1465227833744__endTimestamp 08:43:53 INFO - PROCESS | 28712 | 08:43:53 INFO - PROCESS | 28712 | ------- Summary: start ------- 08:43:53 INFO - PROCESS | 28712 | Number of tests: 14 08:43:53 INFO - PROCESS | 28712 | 08:43:53 INFO - PROCESS | 28712 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.50 stddev:1.96 (1.7%) stddev-sans-first:1.87 08:43:53 INFO - PROCESS | 28712 | Values: 116.0 109.0 113.0 113.0 115.0 114.0 113.0 113.0 115.0 115.0 08:43:53 INFO - PROCESS | 28712 | 08:43:53 INFO - PROCESS | 28712 | [#1] audio-beat-detection Cycles:10 Average:155.60 Median:156.00 stddev:24.73 (15.9%) stddev-sans-first:26.21 08:43:53 INFO - PROCESS | 28712 | Values: 153.0 131.0 154.0 192.0 132.0 164.0 158.0 141.0 201.0 130.0 08:43:53 INFO - PROCESS | 28712 | 08:43:53 INFO - PROCESS | 28712 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:4.69 (2.9%) stddev-sans-first:4.96 08:43:53 INFO - PROCESS | 28712 | Values: 164.0 163.0 166.0 178.0 164.0 163.0 164.0 163.0 163.0 162.0 08:43:53 INFO - PROCESS | 28712 | 08:43:53 INFO - PROCESS | 28712 | [#3] audio-fft Cycles:10 Average:92.10 Median:76.00 stddev:33.15 (43.6%) stddev-sans-first:34.71 08:43:53 INFO - PROCESS | 28712 | Values: 77.0 77.0 76.0 155.0 76.0 77.0 76.0 76.0 155.0 76.0 08:43:53 INFO - PROCESS | 28712 | 08:43:53 INFO - PROCESS | 28712 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:87.00 stddev:27.48 (31.6%) stddev-sans-first:28.47 08:43:53 INFO - PROCESS | 28712 | Values: 87.0 87.0 147.0 87.0 86.0 87.0 146.0 86.0 87.0 137.0 08:43:53 INFO - PROCESS | 28712 | 08:43:53 INFO - PROCESS | 28712 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 08:43:53 INFO - PROCESS | 28712 | Values: 117.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 118.0 117.0 08:43:53 INFO - PROCESS | 28712 | 08:43:53 INFO - PROCESS | 28712 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.00 stddev:2.68 (1.8%) stddev-sans-first:2.83 08:43:53 INFO - PROCESS | 28712 | Values: 148.0 147.0 155.0 148.0 146.0 146.0 148.0 150.0 150.0 147.0 08:43:53 INFO - PROCESS | 28712 | 08:43:53 INFO - PROCESS | 28712 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 08:43:53 INFO - PROCESS | 28712 | Values: 96.0 97.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 08:43:53 INFO - PROCESS | 28712 | 08:43:53 INFO - PROCESS | 28712 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:66.00 stddev:1.29 (1.9%) stddev-sans-first:1.30 08:43:53 INFO - PROCESS | 28712 | Values: 64.0 66.0 65.0 64.0 66.0 63.0 66.0 66.0 64.0 67.0 08:43:53 INFO - PROCESS | 28712 | 08:43:53 INFO - PROCESS | 28712 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.12 08:43:53 INFO - PROCESS | 28712 | Values: 65.0 65.0 66.0 65.0 68.0 65.0 65.0 67.0 67.0 66.0 08:43:53 INFO - PROCESS | 28712 | 08:43:53 INFO - PROCESS | 28712 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:85.00 stddev:9.42 (11.1%) stddev-sans-first:9.67 08:43:53 INFO - PROCESS | 28712 | Values: 82.0 84.0 83.0 89.0 84.0 84.0 91.0 86.0 114.0 90.0 08:43:53 INFO - PROCESS | 28712 | 08:43:53 INFO - PROCESS | 28712 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:139.00 stddev:5.51 (4.0%) stddev-sans-first:5.63 08:43:53 INFO - PROCESS | 28712 | Values: 135.0 147.0 134.0 133.0 146.0 135.0 137.0 147.0 139.0 139.0 08:43:53 INFO - PROCESS | 28712 | 08:43:53 INFO - PROCESS | 28712 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:171.50 stddev:2.30 (1.3%) stddev-sans-first:2.40 08:43:53 INFO - PROCESS | 28712 | Values: 172.0 170.0 175.0 169.0 169.0 173.0 171.0 167.0 170.0 172.0 08:43:53 INFO - PROCESS | 28712 | 08:43:53 INFO - PROCESS | 28712 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:67.00 stddev:3.47 (5.2%) stddev-sans-first:3.64 08:43:53 INFO - PROCESS | 28712 | Values: 67.0 66.0 69.0 66.0 67.0 76.0 73.0 66.0 67.0 66.0 08:43:53 INFO - PROCESS | 28712 | -------- Summary: end -------- 08:43:53 INFO - PROCESS | 28712 | 08:43:54 INFO - TEST-INFO | 28712: exit 0 08:43:54 INFO - TEST-OK | kraken | took 64268ms 08:43:54 INFO - SUITE-END | took 1179s 08:43:54 INFO - Completed test suite (00:19:39) 08:43:54 INFO - javascript benchmark 08:43:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6409.250602045214, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2716.9049083282084, 2755.035737491878, 2758.613794068831, 2761.682406523248, 2773.3066733316673, 4713.835015774449, 4729.858104256873, 4768.070226305872, 4833.178359678855, 4878.0, 4735.928961065587, 4839.854804355866, 4856.271559266112, 4868.221084626461, 4891.021795640868, 4424.070945101533, 4465.732056076646, 4519.728816271017, 4551.408316918796, 4585.839495617654, 4224.112936283384, 4500.392447019643, 4510.887227819298, 4572.497025327211, 4574.130915126132, 4341.544137865541, 4350.456192975878, 4356.956430435686, 4446.0, 4451.198784218839, 4422.09347083847, 4424.446944131983, 4484.5291244419195, 4490.371348011281, 4509.503954564995, 4416.425864637608, 4429.534898835608, 4451.9777401113115, 4466.843660471868, 4525.547445255481, 4638.512956139624, 4720.079584481027, 4725.740084295362, 4742.241241401359, 4761.95238047622, 5171.870703232412, 5184.248283998837, 5187.0, 5196.6881987080515, 5249.265102885599, 5164.870878228075, 5206.583473322125, 5212.452692467275, 5228.607854410896, 5239.73801309933, 4839.201531747292, 4858.611311095175, 4860.125177468054, 4862.222044472867, 4902.803887844482, 5278.392984806719, 5316.9202461963105, 5321.574274058144, 5328.17413300939, 5347.946520534822, 5023.447420783711, 5077.822276220389, 5100.387953445536, 5111.693298402108, 5112.488751124858, 5054.49455054499, 5179.766910489037, 5185.844424667266, 5215.817446389358, 5228.006678731029, 5047.066292735855, 5110.412302585176, 5116.897662046813, 5122.871928201825, 5130.12787826063, 5080.568151707146, 5097.61767867404, 5099.847004589868, 5150.793968241303, 5178.482151784867, 4180.205760905418, 4307.655387568987, 4327.1345730853955, 4339.414179085783, 4369.082492676574, 3797.0886987123445, 3799.2021675448464, 3808.8286027128847, 3832.425136229532, 3844.2695887781233, 4463.866084017484, 4511.593956543861, 4529.8641040768825, 4543.727376357429, 4577.8397756078375, 5110.412302585176, 5151.4333423323405, 5169.483051694876, 5192.0, 5197.324347834758, 4532.0709254602725, 4534.206513860061, 4554.521775213555, 4579.7252164870215, 4607.170709272296, 4616.815327386934, 4619.976900115478, 4646.395968524071, 4656.604188644003, 4689.7655117244, 4708.858734237979, 4876.292937524039, 4900.926486102782, 4903.901921961469, 4920.237363208708, 5206.5314121729225, 5211.166213405837, 5212.582993360446, 5232.869178270574, 5244.5279924806955, 4902.583280421204, 4906.803727850989, 4912.606991440748, 4917.409910810726, 4919.926201107058, 5143.6399452037995, 5164.9741751291, 5187.403448603308, 5197.870053248699, 5206.427292997843, 5216.165413533817, 5263.2631431600375, 5268.736563171749, 5275.366955965309, 5339.546138578109, 4819.807207711652, 4919.3358896549935, 5106.846794596168, 5107.719075450886, 5117.437081920912, 4926.679765815211, 4958.603311734981, 4977.8257760978195, 4982.551570358685, 5025.020121076355, 4868.61051115917, 4884.5603895649565, 4898.583620392164, 4898.7550622468025, 4943.0361079590575, 4837.95162048375, 4999.075171093359, 5037.0, 5063.493650634907, 5075.568576671024, 4974.676646017997, 4982.053409852117, 4998.550130488128, 5006.274090256965, 5048.368953880765], "value": 4751.56932819919, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.5475445549145, 578.997105014475, 582.283790937147, 601.9849503762404, 615.5414216408776, 35315.64684353159, 38995.0, 39100.80449597755, 39130.804345978264, 39191.21617567654, 37045.44431833525, 37207.06982325443, 37311.0, 37628.247435051286, 37662.435063474004, 7497.5876326802145, 7599.050118735158, 7642.388608911274, 7668.654910529011, 7668.65491052904, 7748.147703752583, 7876.684932602689, 7879.527228366288, 7894.921050789505, 7898.723544675938, 7823.2567906048835, 7880.763577092696, 7883.172266911978, 7897.921020789805, 7914.445988780788, 7712.6914923403, 7730.729424470116, 7765.572893490856, 7824.1002284737415, 7868.6065696715505, 7583.544987300779, 7625.313721765067, 7638.236176382373, 7645.770626881203, 7667.386609071261, 37652.0, 37856.0, 37902.43146352807, 37996.24007519862, 38048.23903521942, 3049.1767222849926, 3309.586301712286, 3419.452887538007, 3585.6772890439725, 3722.683571896392, 28898.855505722546, 29204.44203521987, 29251.70748292511, 30450.69549304523, 30472.695273047208, 3345.498175273704, 3406.9659303406897, 3435.7594968352223, 3466.2027733621157, 3591.515145455356, 245885.0, 247402.0, 248140.9999999982, 248699.0, 248922.0, 52910.0, 53188.46811531835, 53438.465615343346, 53454.73272633612, 53513.73243133837, 33534.0, 34338.141546461535, 34376.65623343785, 35520.223988800455, 57674.423255767746, 13480.191188528719, 13535.187888726708, 13572.728545429036, 13581.592552223448, 13591.728165436636, 10235.078842904175, 10246.590136394461, 10251.077403033763, 10266.435346056038, 10269.281150319406, 18546.44360669182, 18552.165152568166, 18670.53323666919, 18767.0, 18837.62324753497, 6730.528862979544, 6834.863302733917, 6912.55068420551, 7049.330313620198, 7051.1891132519395, 774.6243072110135, 856.8243510080418, 953.9983017831388, 982.268210183418, 1045.8901815309434, 27816.860915695695, 28713.71286287152, 28730.425391492052, 31961.840190798895, 32040.519392209135, 924.4822899176482, 927.8840144981878, 991.5934466868549, 1030.1192480429124, 1037.0044757033334, 14695.412183512753, 15015.924920375328, 15086.245687715571, 15378.84621153774, 15458.922705386402, 365047.0, 369036.0, 369773.0, 369908.0, 371430.0, 50109.74945125324, 50202.49797502051, 50406.243906341435, 50674.0, 50783.74608126936, 1203.48851738011, 1243.055277988735, 1255.8241846141548, 1258.9307588082743, 1262.8421447319085, 27336.453270934868, 28508.85745571259, 28699.13902582926, 28737.281567960967, 28856.422871542873, 43187.784061079496, 44302.77848610736, 44332.77833610812, 44358.55641443544, 44416.333754994346, 324084.0, 325798.0, 326111.0, 327455.0, 327837.0, 25434.364140896625, 25669.791276090487, 26214.34464138412, 26234.0, 26361.472770544096, 42077.46039354402, 42927.570724293604, 42995.0, 43398.56601433945, 43875.56124438715, 36933.0, 36990.260194796494, 37446.43830342602, 37566.2486750258, 37743.62256377511, 36943.26113477769, 37053.44419833651, 37141.257174856895, 37232.81383593065, 37328.62671373251, 30161.547576785928, 35425.64574354327, 35712.28575428529, 35848.46227306645, 36574.4513832298, 31558.211044724067, 33178.834105829315, 33182.668173318925, 33297.50053749147, 33394.83302583569, 24941.501169976134, 25238.242852714448, 25317.87341063283, 25881.96472141093, 25908.61137082983], "value": 17447.56494616152, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.28661959531945, 354.36568542309266, 357.69595843533, 366.73228543163475, 374.5636333671273, 15686.921565392171, 16659.25033373498, 16769.24538395772, 16933.83066169338, 17129.657406851857, 16009.838671779306, 16725.494705476503, 16957.66084678309, 17052.658946821055, 17070.14649267538, 4902.3872015998, 5074.847754567369, 5095.745212739367, 5105.081085404626, 5117.769700363474, 3785.0915780212827, 4937.481564435737, 5695.544356451494, 5964.552658550626, 5980.88038239235, 5963.701814909237, 5991.370906054867, 6003.129546215796, 6010.218671572711, 6016.0, 5712.6286791358425, 5882.705864706748, 5921.289445266552, 5934.851628709295, 5953.434423729739, 4611.608013318872, 5145.948540514584, 5185.118529849935, 5186.351706036746, 5186.766595503212, 11217.943910280397, 11670.008049315818, 11704.47329870158, 11738.823917641157, 11779.941100294443, 1746.6943284925087, 1839.5677015901254, 1896.7439395681683, 2103.2112957640884, 2340.993372849674, 8646.351523635689, 8670.436421632574, 8696.999845017841, 8818.470891746452, 9000.59497322622, 1588.3011474950983, 1602.1028224194488, 1616.991915040429, 1645.424101564443, 1692.4668729350337, 70557.0, 71018.64490677514, 71052.0, 71928.0, 72969.0, 9337.486438245962, 9392.248620110375, 9521.428714277166, 9588.232941364675, 9743.171830394354, 12974.221546707227, 13032.087753857139, 13033.934830325978, 13042.804357934638, 13082.738345233041, 7200.603966781878, 7213.603251821095, 7236.457265704988, 7312.926870731331, 7340.779776606711, 6991.475639327071, 7011.789646310619, 7021.789346319619, 7127.92872071283, 7146.892796608055, 4048.4332193492933, 4097.160082183145, 4131.29767939451, 4143.502779666459, 4150.1284730207, 1558.6648870492672, 1655.2716804606175, 1662.6924019056514, 1738.8695847811464, 1785.1877395784886, 847.1316900177368, 925.7037747920735, 928.8374534456443, 930.9162175404247, 931.1991687149047, 16258.918705406397, 16596.0, 17145.914270428817, 17182.0, 17253.39613113535, 853.7182729699184, 875.4397185801092, 883.1389395339493, 885.9291256699448, 948.0188005414363, 5164.690118592896, 9563.952180239054, 9617.182539484222, 9630.807383852283, 9768.12086912167, 384113.0, 393131.0, 395073.0, 396942.0, 404045.0, 71931.28068719245, 74096.62951685207, 79170.0, 79880.60059699665, 81866.59066704629, 913.3789023463976, 917.6100157433198, 923.4597760310294, 944.0229362609666, 945.2485274207022, 14339.283035848375, 15063.623409414853, 15237.161956092521, 15379.077255364715, 15428.537143885702, 34612.82693586516, 34683.30633387268, 35976.82011589925, 36114.27771444504, 36456.0, 46883.53116468928, 48574.0, 48757.756211218715, 49070.75464622654, 49559.0, 6279.0, 6554.0, 6871.862562748817, 7139.750108746169, 7473.5426591814075, 12061.216020958609, 12197.451114699683, 12203.450844712186, 12349.62951111432, 12370.62888113358, 10367.222458315808, 10446.738831529272, 10586.788264234518, 10700.678979630624, 10790.514426850968, 10502.10732087781, 10666.946665266934, 10673.94663026711, 10727.141828653534, 10740.087092597218, 10690.41202733857, 10753.408562529135, 10789.244752867538, 10793.08258798011, 10878.744324144094, 6854.246032936273, 6854.3145685433055, 6863.210730765826, 6897.620630865351, 7040.331168538981, 9172.587233574639, 9711.708648740549, 9888.851667224853, 10061.496925153859, 10455.634052808115], "value": 7988.411811406149, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.6480212347974, 1450.5068276785894, 1579.0762403993663, 1756.6486702659472, 1779.5195297269738, 7012.158540975091, 7549.509281896673, 7733.342665873401, 8278.875816862745, 8289.626966786494, 7627.580483073429, 7742.070951485815, 7828.099768526621, 7865.567393793339, 7890.56601886896, 2190.5837890800776, 2220.467087898901, 2226.565819665166, 2227.9777202228015, 2236.1726161320335, 2134.964542197033, 2138.134055707441, 2141.2077531313435, 2141.4646338415396, 2179.7384313882358, 2138.647123224666, 2139.775323591024, 2145.3992881993067, 2145.753238377591, 2187.9671804922937, 2104.9789502104936, 2116.7036614873778, 2120.204923153817, 2120.5228823514817, 2122.883241421737, 2070.0581235537793, 2088.832893368542, 2105.620988222119, 2120.4804822818355, 2124.3945475539554, 7801.141874393812, 7829.608519574055, 7885.960570197112, 7903.762887113396, 7912.920870791276, 4601.194790911577, 4668.813247470097, 4709.222978208626, 4729.26696362061, 4758.976205118952, 2804.4531316393313, 2906.4913640112895, 2914.446255211503, 2915.096320140763, 2926.6049083373687, 821.6425854753202, 872.2890843962214, 874.3660845886745, 892.6830975003845, 893.5934149961752, 11019.449027548591, 11027.724306892393, 11068.778624427547, 11101.611443599435, 11180.496877640526, 4289.420928174719, 4344.45694288214, 4398.208322501916, 4436.933445998313, 4444.355568442557, 9403.623855045858, 9409.764755881159, 9413.294002949806, 9414.435133891851, 9420.90579094214, 4570.862874113782, 4598.97700511502, 4621.930671039937, 4628.444586649556, 4636.559526844944, 3725.6274372562525, 3931.5085614298214, 4059.3099173140636, 4193.266178418826, 4222.831086756557, 3694.946940122052, 3723.0878434783654, 3736.626337366296, 3764.6235376462137, 3816.2367526494813, 1174.8237764335247, 1217.8660347361783, 1218.3360068762368, 1225.6506895534908, 1233.4326209943347, 702.6873041496485, 757.8257000889827, 823.4976664234812, 937.8452555328295, 943.1087622196958, 5535.280413546213, 5607.45794906404, 5616.1014237721765, 5636.774529018793, 5703.714814259353, 836.2056046755606, 878.5651102704202, 942.8350038743192, 945.9716208513755, 953.5994882149375, 3925.528936527635, 3925.548561915359, 3948.249832531867, 3959.5050618672667, 4008.7995600219874, 9798.118169364792, 10149.797004059878, 10178.13485853696, 10179.643712470028, 10187.490625468845, 9960.252981026451, 9998.300118991601, 10032.046955539212, 10070.798584028278, 10091.798164036678, 7469.58917259556, 7647.0441194851755, 7677.424193185533, 7677.731279405306, 7695.653695583712, 5517.475839795213, 5745.74144163522, 5749.166370876116, 5758.2514273144225, 5807.332156801853, 9045.0, 9260.583273752563, 9267.490288034223, 9288.58201380926, 9299.209567186594, 9095.363324567481, 9247.86128208064, 9299.349045566745, 9314.906850931404, 9536.141747242782, 6623.6688165592495, 6659.966700166468, 6841.452683785385, 6855.485838562227, 6862.0, 7648.923510765044, 7655.425843061904, 7660.2722741339485, 7681.5775132366025, 7712.460127791001, 6785.321467853175, 6917.9308206917285, 7152.427805775629, 7280.9271907280245, 7295.23400043009, 6974.37230649244, 7023.069677503059, 7051.365377116084, 7064.32888875556, 7132.358087772125, 6586.967065164644, 6694.665266736741, 6718.93281067183, 6719.697613607497, 6735.259121496533, 4592.219322715213, 4602.217623004164, 4926.451215207951, 5049.823256186016, 5056.039352523009, 4984.2025275955675, 5012.423571289202, 5106.438291787826, 5141.408737995179, 5166.147585648326], "value": 4254.740250005538, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.5973636908328, 289.5483046447542, 293.2068754020375, 293.5025132400581, 294.22618513310016, 4924.753762311883, 4988.052270068684, 5049.419316778572, 5055.24171374294, 5065.544101030907, 4917.631177661672, 4952.529509696582, 4959.851204463863, 4967.478414766451, 4971.204607262839, 3680.668739813423, 3734.8319325630414, 3805.2769973705044, 3819.0, 3862.613738626143, 3840.923181536368, 3855.556610989744, 3877.418387241922, 3891.3968334908136, 3901.921961560767, 3864.265789499986, 3876.7286289959575, 3878.9806050969705, 3884.7863367514774, 3887.786171760552, 3795.2409518096492, 3804.5624753153465, 3860.498135242429, 3872.883813485586, 3881.1849511602595, 3365.5288259643426, 3369.2250782319957, 3369.747268954838, 3374.240795820945, 3376.3416133853907, 4803.255495398219, 4811.0, 4811.639127065449, 4813.08551375241, 4814.711117332936, 4399.834043978349, 4416.2713152329825, 4433.645308375322, 4454.354118652777, 4457.420535330419, 5049.697018178921, 5178.171492561172, 5201.609879259071, 5206.921896171561, 5273.789048438058, 3683.834227459771, 3705.4441833724886, 3709.2766910452474, 3731.6828069614116, 3735.869244576454, 5482.0, 5531.778728850841, 5540.889182216373, 5543.307086614213, 5548.557375082467, 3590.605033446319, 3809.0286976820735, 3818.1409182933617, 3825.6556909877686, 3861.420786881934, 3877.127646279621, 3882.417637354363, 3889.416587511896, 3893.0267433141717, 3897.9610203898164, 4437.912711385731, 4441.68908176431, 4443.844465443694, 4454.821807127743, 4458.729262160269, 4968.925466118011, 5274.077036518594, 5277.179373116269, 5297.17893726473, 5333.173358129496, 1309.5416604188458, 1323.5764555342391, 1327.9668008299677, 1330.8203392542077, 1332.1074879830537, 823.4482896459386, 859.4027151129904, 859.4542465534431, 878.3763527895138, 878.6836738774036, 4560.589546940725, 4614.123316569841, 4619.330197121399, 4638.165130276582, 4657.0, 5377.220303056035, 5396.595255355785, 5414.945850541523, 5424.511793938565, 5453.291072160594, 4479.477361111761, 4638.770725757677, 4639.37368455261, 4665.370175026328, 4691.756684478616, 2846.573014047868, 2865.2550336912554, 2871.196065101775, 2873.252954231915, 2897.2032691009717, 5066.949330506648, 5110.616703747234, 5127.564157046618, 5156.401515530198, 5161.0, 5297.231901374279, 5563.276774019351, 5590.608657394025, 5599.608027438122, 5655.501292157582, 5154.407243167008, 5178.896422071537, 5186.196139598368, 5187.377514698185, 5195.74021298926, 5456.345238571397, 5485.6434331768305, 5491.203775452457, 5495.450454954473, 5519.530839878495, 5167.379914410295, 5326.8934621308135, 5372.838814835562, 5375.193720941734, 5393.191021346829, 5116.155834287301, 5122.769475373691, 5124.2321399117245, 5125.410577783454, 5156.793728250828, 3726.142987112925, 3753.211825516672, 3774.698024158116, 3775.6030268799623, 3794.108384529578, 5370.194470829407, 5439.292891924183, 5445.264889239902, 5457.536109430743, 5554.916676249779, 5261.237120617566, 5295.232191332312, 5302.3637163540625, 5311.3891902431715, 5320.840374788762, 5287.7620507078045, 5294.49702278283, 5296.920546191887, 5307.044731948132, 5307.726145724921, 4979.775910083982, 5225.085610018307, 5253.553447956967, 5271.551918087006, 5271.762770675406, 5101.3113229715, 5194.0, 5329.893402132013, 5331.653442526223, 5347.786088556414, 5203.505666961632, 5208.166693329201, 5212.348456442945, 5219.321488206509, 5220.321358223407], "value": 3944.085522750802, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.6696884588861, 667.5980441073746, 711.7864640607818, 712.6614857942475, 730.6748496918871, 12119.697007574816, 12488.875111248884, 12655.0, 12658.683532911682, 12682.3658817059, 11828.526858925632, 11903.64289071327, 11967.46146423411, 11968.700782480442, 11973.341466219375, 621.0994058615004, 767.6238643064886, 770.7957391291326, 780.9219078092174, 783.2324322164283, 778.5289899610739, 782.2763943352377, 783.0994356490054, 783.4476693930765, 783.8667426537473, 830.3689196210863, 835.8161204534993, 840.7603832907622, 840.8276303357796, 842.6671464771412, 825.405707890318, 828.8756686497013, 829.6805729794013, 830.8047608811925, 833.7915521119751, 603.0592276049377, 607.1924340626956, 608.2791891608458, 610.2554883042725, 611.10778263735, 12374.319412432402, 12379.0, 12381.195222310522, 12404.81392779109, 12414.75170496594, 13280.667983300495, 13366.550803335733, 13493.662658433519, 13709.0, 13787.379567919468, 10087.798244035152, 10124.898751012543, 10221.182305415623, 10318.535665894977, 10504.894951050468, 3340.231746698273, 3343.2477692518987, 3430.1939044324563, 3436.329915666446, 3461.826908654557, 49577.75211123958, 51928.74035629835, 52024.0, 57183.428165718644, 57672.42327576713, 9888.752781180385, 10004.0, 10243.282970192164, 10312.484375781181, 10382.273240873066, 16220.0, 16237.431689890796, 16243.918780406022, 16282.83717162837, 17172.05553694534, 7219.819504512429, 7251.963740181371, 7311.524750891175, 7321.121465424183, 7454.366378857858, 3948.58539853317, 4036.990752311922, 4056.3104272273786, 4067.8779636610357, 4068.7355321904574, 3012.487877060905, 3114.034649258737, 3120.8439578021007, 3121.438141134572, 3123.9219019524694, 533.2001997004493, 541.5910987204635, 554.4372461951123, 557.2115456628906, 561.6489693941287, 502.86171302891995, 561.7303694226713, 608.1091201389985, 639.1467391033023, 645.141961191614, 8570.828583428296, 8721.951122452589, 8727.170918762835, 8938.24024957886, 9031.77420564478, 514.2543312197329, 591.0, 594.7450878646054, 621.810347843903, 624.4536030972898, 3684.9263014739554, 3797.9050523736573, 3800.051769109801, 3887.047673319998, 3951.0122469382654, 89481.55259223662, 90378.0, 91083.54458227666, 93567.53216233876, 93933.5303323479, 72329.0, 77009.61495192489, 77815.61092194503, 78523.60738196272, 79136.6043169792, 68617.65691171613, 68900.31099689039, 69216.0, 69630.65184674044, 70040.89877303792, 6958.895616565655, 7226.891596625949, 7894.565798881116, 8271.793205169919, 8350.03974542911, 39522.80238598789, 41144.79427602843, 41323.96690082772, 42139.578604213566, 44005.55994440143, 59319.06352511149, 61624.383756161864, 62740.68629656822, 63039.36960630335, 63319.6834015827, 8995.280377569648, 9001.234895033733, 9097.954510227406, 9152.58813353414, 9397.812043759222, 9637.469939153414, 9690.806183876424, 10091.041351071637, 10282.0, 10317.226208034577, 9979.750506237402, 10018.198544116307, 10182.134518566005, 10525.0, 10594.046535811814, 9550.283728720235, 9793.314467987457, 9878.30851840393, 9920.900790992286, 10039.4478303694, 9751.609935602497, 9892.0, 9905.257105717244, 9907.554160062959, 9908.504574771378, 7719.228077192236, 7820.491668041559, 7829.765107046797, 7988.8002799928145, 8407.201315874981, 7101.0, 7333.413326933725, 7398.593077380796, 7403.074615673041, 7600.403915177874], "value": 6236.57141727173, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 113.0, 113.0, 115.0, 114.0, 113.0, 113.0, 115.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 131.0, 154.0, 192.0, 132.0, 164.0, 158.0, 141.0, 201.0, 130.0], "value": 155.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 166.0, 178.0, 164.0, 163.0, 164.0, 163.0, 163.0, 162.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 155.0, 76.0, 77.0, 76.0, 76.0, 155.0, 76.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 147.0, 87.0, 86.0, 87.0, 146.0, 86.0, 87.0, 137.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 155.0, 148.0, 146.0, 146.0, 148.0, 150.0, 150.0, 147.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 64.0, 66.0, 63.0, 66.0, 66.0, 64.0, 67.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 68.0, 65.0, 65.0, 67.0, 67.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 83.0, 89.0, 84.0, 84.0, 91.0, 86.0, 114.0, 90.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 147.0, 134.0, 133.0, 146.0, 135.0, 137.0, 147.0, 139.0, 139.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 175.0, 169.0, 169.0, 173.0, 171.0, 167.0, 170.0, 172.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 69.0, 66.0, 67.0, 76.0, 73.0, 66.0, 67.0, 66.0], "value": 68.3, "unit": "score"}]}]} 08:43:54 INFO - Return code: 0 08:43:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:43:55 ERROR - # TBPL SUCCESS # 08:43:55 INFO - Running post-action listener: _resource_record_post_action 08:43:55 INFO - ##### 08:43:55 INFO - ##### Finished run-tests step (success) 08:43:55 INFO - ##### 08:43:55 INFO - Running post-run listener: _resource_record_post_run 08:43:55 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 535969792; Read time: 0; Write time: 413256 08:43:55 INFO - TinderboxPrint: CPU usage
13.4% 08:43:55 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:43:55 INFO - TinderboxPrint: I/O write bytes / time
535,969,792 / 413,256 08:43:55 INFO - TinderboxPrint: CPU idle
8,269.6 (86.6%) 08:43:55 INFO - TinderboxPrint: CPU user
1,227.7 (12.9%) 08:43:55 INFO - TinderboxPrint: Swap in / out
0 / 0 08:43:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 174817280; Read time: 0; Write time: 171484 08:43:55 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 298045440; Read time: 0; Write time: 209040 08:43:55 INFO - Running post-run listener: _upload_blobber_files 08:43:55 INFO - Blob upload gear active. 08:43:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:43:55 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 08:43:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:43:56 INFO - (blobuploader) - INFO - Open directory for files ... 08:43:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:43:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:43:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:56 INFO - (blobuploader) - INFO - Done attempting. 08:43:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:43:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:44:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:00 INFO - (blobuploader) - INFO - Done attempting. 08:44:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:44:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:44:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:00 INFO - (blobuploader) - INFO - Done attempting. 08:44:00 INFO - (blobuploader) - INFO - Iteration through files over. 08:44:00 INFO - Return code: 0 08:44:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:44:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:44:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f0a3f0cc05d932c6fc99d86a103ba172e154beb7f4475dde57ee485cc41a38255fe19d8e510109f788a0e3ee46492fe769d144d2c86b5d6807335267a891206", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e182c5905dfea1e600577a3c7c2ed03d035115b7fdd50a7d42c47b486c8ca2ecd2abff5858c7198fe5b0c6dbaf133990c14ad27a1cb12ad0ad82cd75aa32bd1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93056eb21fab6713783da455cbba78304acb848126fc26c2027c46aadfef528a3fdb78e2afd9474fa054647882e88972ee645479be8e0fec3fa42b082ca48729"} 08:44:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:44:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:44:00 INFO - Contents: 08:44:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f0a3f0cc05d932c6fc99d86a103ba172e154beb7f4475dde57ee485cc41a38255fe19d8e510109f788a0e3ee46492fe769d144d2c86b5d6807335267a891206", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e182c5905dfea1e600577a3c7c2ed03d035115b7fdd50a7d42c47b486c8ca2ecd2abff5858c7198fe5b0c6dbaf133990c14ad27a1cb12ad0ad82cd75aa32bd1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93056eb21fab6713783da455cbba78304acb848126fc26c2027c46aadfef528a3fdb78e2afd9474fa054647882e88972ee645479be8e0fec3fa42b082ca48729"} 08:44:00 INFO - Running post-run listener: copy_logs_to_upload_dir 08:44:00 INFO - Copying logs to upload dir... 08:44:00 INFO - mkdir: /builds/slave/test/build/upload/logs 08:44:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.863139 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-06 08:44:00.832106) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 08:44:00.836179) ========= 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=4300f881736b422476174874000001bc-1465226577.692756-1766208441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f0a3f0cc05d932c6fc99d86a103ba172e154beb7f4475dde57ee485cc41a38255fe19d8e510109f788a0e3ee46492fe769d144d2c86b5d6807335267a891206", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e182c5905dfea1e600577a3c7c2ed03d035115b7fdd50a7d42c47b486c8ca2ecd2abff5858c7198fe5b0c6dbaf133990c14ad27a1cb12ad0ad82cd75aa32bd1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93056eb21fab6713783da455cbba78304acb848126fc26c2027c46aadfef528a3fdb78e2afd9474fa054647882e88972ee645479be8e0fec3fa42b082ca48729"} build_url:https://queue.taskcluster.net/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/UjjljLnTQMCKOrrPOXVayA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f0a3f0cc05d932c6fc99d86a103ba172e154beb7f4475dde57ee485cc41a38255fe19d8e510109f788a0e3ee46492fe769d144d2c86b5d6807335267a891206", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e182c5905dfea1e600577a3c7c2ed03d035115b7fdd50a7d42c47b486c8ca2ecd2abff5858c7198fe5b0c6dbaf133990c14ad27a1cb12ad0ad82cd75aa32bd1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93056eb21fab6713783da455cbba78304acb848126fc26c2027c46aadfef528a3fdb78e2afd9474fa054647882e88972ee645479be8e0fec3fa42b082ca48729"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 08:44:00.866724) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 08:44:00.867256) ========= 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=4300f881736b422476174874000001bc-1465226577.692756-1766208441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 08:44:00.945801) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 08:44:00.946169) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 08:44:00.946504) ========= ========= Total master_lag: 0.25 =========