builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1461911432.83 results: success (0) buildid: 20160428203144 builduid: f28a7a589f7e48ce86929115f98b9a5c revision: 0e049ed7092053c46c959e9e2e276fce84a13870 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 23:30:32.832160) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 23:30:32.832952) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 23:30:32.833252) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 23:30:32.898772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 23:30:32.899086) ========= 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=a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 23:30:33-- 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% 218M=0s 2016-04-28 23:30:33 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134252 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 23:30:33.046586) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 23:30:33.046897) ========= 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=a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019791 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 23:30:33.099745) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 23:30:33.100132) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0e049ed7092053c46c959e9e2e276fce84a13870 --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 0e049ed7092053c46c959e9e2e276fce84a13870 --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=a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 23:30:33,645 truncating revision to first 12 chars 2016-04-28 23:30:33,645 Setting DEBUG logging. 2016-04-28 23:30:33,646 attempt 1/10 2016-04-28 23:30:33,646 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0e049ed70920?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 23:30:34,146 unpacking tar archive at: fx-team-0e049ed70920/testing/mozharness/ program finished with exit code 0 elapsedTime=0.781038 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 23:30:33.894908) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 23:30:33.895231) ========= script_repo_revision: 0e049ed7092053c46c959e9e2e276fce84a13870 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 23:30:33.895622) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 23:30:33.895883) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 23:30:33.904920) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-28 23:30:33.905321) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:30:34 INFO - MultiFileLogger online at 20160428 23:30:34 in /builds/slave/test 23:30:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:30:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:30:34 INFO - {'append_to_log': False, 23:30:34 INFO - 'base_work_dir': '/builds/slave/test', 23:30:34 INFO - 'blob_upload_branch': 'Fx-Team', 23:30:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:30:34 INFO - 'branch': 'Fx-Team', 23:30:34 INFO - 'buildbot_json_path': 'buildprops.json', 23:30:34 INFO - 'config_files': ('talos/linux_config.py',), 23:30:34 INFO - 'default_actions': ('clobber', 23:30:34 INFO - 'read-buildbot-config', 23:30:34 INFO - 'download-and-extract', 23:30:34 INFO - 'populate-webroot', 23:30:34 INFO - 'create-virtualenv', 23:30:34 INFO - 'install', 23:30:34 INFO - 'run-tests'), 23:30:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:30:34 INFO - 'download_minidump_stackwalk': True, 23:30:34 INFO - 'download_symbols': 'ondemand', 23:30:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:30:34 INFO - 'tooltool.py': '/tools/tooltool.py', 23:30:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:30:34 INFO - '/tools/misc-python/virtualenv.py')}, 23:30:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:30:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:30:34 INFO - 'installer_path': 'installer.exe', 23:30:34 INFO - 'log_level': 'info', 23:30:34 INFO - 'log_name': 'talos', 23:30:34 INFO - 'log_to_console': True, 23:30:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:30:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:30:34 INFO - 'opt_config_files': (), 23:30:34 INFO - 'pip_index': False, 23:30:34 INFO - 'sps_profile': False, 23:30:34 INFO - 'sps_profile_interval': 0, 23:30:34 INFO - 'suite': 'dromaeojs-e10s', 23:30:34 INFO - 'system_bits': '32', 23:30:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:30:34 INFO - 'title': 'talos-linux64-ix-002', 23:30:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:30:34 INFO - 'use_talos_json': True, 23:30:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:30:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:30:34 INFO - 'work_dir': 'build'} 23:30:34 INFO - ##### 23:30:34 INFO - ##### Running clobber step. 23:30:34 INFO - ##### 23:30:34 INFO - Running pre-action listener: _resource_record_pre_action 23:30:34 INFO - Running main action method: clobber 23:30:34 INFO - rmtree: /builds/slave/test/build 23:30:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:30:35 INFO - Running post-action listener: _resource_record_post_action 23:30:35 INFO - ##### 23:30:35 INFO - ##### Running read-buildbot-config step. 23:30:35 INFO - ##### 23:30:35 INFO - Running pre-action listener: _resource_record_pre_action 23:30:35 INFO - Running main action method: read_buildbot_config 23:30:35 INFO - Using buildbot properties: 23:30:35 INFO - { 23:30:35 INFO - "project": "", 23:30:35 INFO - "product": "firefox", 23:30:35 INFO - "script_repo_revision": "production", 23:30:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:30:35 INFO - "repository": "", 23:30:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:30:35 INFO - "buildid": "20160428203144", 23:30:35 INFO - "pgo_build": "True", 23:30:35 INFO - "basedir": "/builds/slave/test", 23:30:35 INFO - "buildnumber": 422, 23:30:35 INFO - "slavename": "talos-linux64-ix-002", 23:30:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:30:35 INFO - "platform": "ubuntu64_hw", 23:30:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:30:35 INFO - "branch": "fx-team", 23:30:35 INFO - "repo_path": "integration/fx-team", 23:30:35 INFO - "revision": "0e049ed7092053c46c959e9e2e276fce84a13870", 23:30:35 INFO - "stage_platform": "linux64-pgo", 23:30:35 INFO - "builduid": "f28a7a589f7e48ce86929115f98b9a5c", 23:30:35 INFO - "slavebuilddir": "test" 23:30:35 INFO - } 23:30:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:30:35 INFO - Running post-action listener: _resource_record_post_action 23:30:35 INFO - ##### 23:30:35 INFO - ##### Running download-and-extract step. 23:30:35 INFO - ##### 23:30:35 INFO - Running pre-action listener: _resource_record_pre_action 23:30:35 INFO - Running main action method: download_and_extract 23:30:35 INFO - mkdir: /builds/slave/test/build/tests 23:30: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')]} 23:30:35 INFO - https://queue.taskcluster.net/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:30:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:30:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:30:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/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 23:30:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/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 23:30:44 INFO - Downloaded 1361 bytes. 23:30:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:30:44 INFO - Using the following test package requirements: 23:30:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:30:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:30:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:30:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:30:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:30:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:30:44 INFO - u'jsshell-linux-x86_64.zip'], 23:30:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:30:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:30:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:30:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:30:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:30:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:30:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:30:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:30:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:30:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:30:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:30:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:30:44 INFO - https://queue.taskcluster.net/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:30:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:30:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:30:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/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 23:30:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/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 23:30:46 INFO - Downloaded 23873441 bytes. 23:30:46 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'] 23:30:46 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 23:30:47 INFO - Return code: 0 23:30:47 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 23:30: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')]} 23:30:47 INFO - https://queue.taskcluster.net/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:30:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:30:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:30:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/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 23:30:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/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 23:30:51 INFO - Downloaded 23873441 bytes. 23:30:51 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'] 23:30:51 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 23:30:52 INFO - Return code: 0 23:30:52 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')]} 23:30:52 INFO - https://queue.taskcluster.net/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:30:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:30:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:30:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/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 23:30:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/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 23:30:54 INFO - Downloaded 10840145 bytes. 23:30:54 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'] 23:30:54 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 23:30:54 INFO - Return code: 0 23:30: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')]} 23:30:54 INFO - https://queue.taskcluster.net/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:30:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:30:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:30:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/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 23:30:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QsVWERSuSYernE-DSuCtwA/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 23:30:56 INFO - Downloaded 58401644 bytes. 23:30:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:30:56 INFO - mkdir: /builds/slave/test/properties 23:30:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:30:56 INFO - Writing to file /builds/slave/test/properties/build_url 23:30:56 INFO - Contents: 23:30:56 INFO - build_url:https://queue.taskcluster.net/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:30:56 INFO - Running post-action listener: _resource_record_post_action 23:30:56 INFO - Running post-action listener: set_extra_try_arguments 23:30:56 INFO - ##### 23:30:56 INFO - ##### Running populate-webroot step. 23:30:56 INFO - ##### 23:30:56 INFO - Running pre-action listener: _resource_record_pre_action 23:30:56 INFO - Running main action method: populate_webroot 23:30:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:30:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:30:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:30:56 INFO - '--tppagecycles', 23:30:56 INFO - '7'], 23:30:56 INFO - 'tests': ['tsvgm']}}, 23:30:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:30:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:30:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:30:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:30:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:30:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:30:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:56 INFO - 'talos_options': ['--disable-e10s'], 23:30:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:30:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:30:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:56 INFO - 'talos_options': ['--disable-e10s'], 23:30:56 INFO - 'tests': ['damp', 'tps']}, 23:30:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:56 INFO - 'tests': ['damp', 'tps']}, 23:30:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:30:56 INFO - 'tests': ['dromaeo_dom']}, 23:30:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:30:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:30:56 INFO - 'tests': ['a11yr', 23:30:56 INFO - 'ts_paint', 23:30:56 INFO - 'tpaint', 23:30:56 INFO - 'sessionrestore', 23:30:56 INFO - 'sessionrestore_no_auto_restore', 23:30:56 INFO - 'tabpaint']}, 23:30:56 INFO - 'other-e10s': {'tests': ['a11yr', 23:30:56 INFO - 'ts_paint', 23:30:56 INFO - 'tpaint', 23:30:56 INFO - 'sessionrestore', 23:30:56 INFO - 'sessionrestore_no_auto_restore', 23:30:56 INFO - 'tabpaint']}, 23:30:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:30:56 INFO - 'ts_paint', 23:30:56 INFO - 'tpaint', 23:30:56 INFO - 'sessionrestore', 23:30:56 INFO - 'sessionrestore_no_auto_restore', 23:30:56 INFO - 'tabpaint']}, 23:30:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:30:56 INFO - 'ts_paint', 23:30:56 INFO - 'tpaint', 23:30:56 INFO - 'sessionrestore', 23:30:56 INFO - 'sessionrestore_no_auto_restore', 23:30:56 INFO - 'tabpaint']}, 23:30:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:30:56 INFO - 'tests': ['a11yr', 23:30:56 INFO - 'ts_paint', 23:30:56 INFO - 'tpaint', 23:30:56 INFO - 'sessionrestore', 23:30:56 INFO - 'sessionrestore_no_auto_restore', 23:30:56 INFO - 'tabpaint']}, 23:30:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:30:56 INFO - 'tests': ['a11yr', 23:30:56 INFO - 'ts_paint', 23:30:56 INFO - 'tpaint', 23:30:56 INFO - 'sessionrestore', 23:30:56 INFO - 'sessionrestore_no_auto_restore', 23:30:56 INFO - 'tabpaint']}, 23:30:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:30:56 INFO - 'tests': ['tsvgx', 23:30:56 INFO - 'tsvgr_opacity', 23:30:56 INFO - 'tart', 23:30:56 INFO - 'tscrollx', 23:30:56 INFO - 'cart']}, 23:30:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:30:56 INFO - 'tsvgr_opacity', 23:30:56 INFO - 'tart', 23:30:56 INFO - 'tscrollx', 23:30:56 INFO - 'cart']}, 23:30:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:56 INFO - 'talos_options': ['--disable-e10s'], 23:30:56 INFO - 'tests': ['tp5o']}, 23:30:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:56 INFO - 'tests': ['tp5o']}, 23:30:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:56 INFO - 'talos_options': ['--disable-e10s', 23:30:56 INFO - '--xperf_path', 23:30:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:30:56 INFO - 'tests': ['tp5n']}, 23:30:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:30:56 INFO - 'talos_options': ['--xperf_path', 23:30:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:30:56 INFO - 'tests': ['tp5n']}}, 23:30:56 INFO - 'talos.zip': {'path': '', 23:30:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:30:56 INFO - Running post-action listener: _resource_record_post_action 23:30:56 INFO - ##### 23:30:56 INFO - ##### Running create-virtualenv step. 23:30:56 INFO - ##### 23:30:56 INFO - Running pre-action listener: _resource_record_pre_action 23:30:56 INFO - Running main action method: create_virtualenv 23:30:56 INFO - Creating virtualenv /builds/slave/test/build/venv 23:30:56 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 23:30:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:30:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:30:57 INFO - Using real prefix '/usr' 23:30:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:30:57 INFO - Installing distribute.............................................................................................................................................................................................done. 23:30:59 INFO - Installing pip.................done. 23:30:59 INFO - Return code: 0 23:30:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6f6086cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f117d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0640>, '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 0x1fa1540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa19d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', '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 23:30:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:30:59 INFO - Using env: {'DISPLAY': ':0', 23:30:59 INFO - 'HOME': '/home/cltbld', 23:30:59 INFO - 'LANG': 'en_US.UTF-8', 23:30:59 INFO - 'LANGUAGE': 'en_US:en', 23:30:59 INFO - 'LOGNAME': 'cltbld', 23:30:59 INFO - 'MAIL': '/var/mail/cltbld', 23:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:59 INFO - 'MOZ_NO_REMOTE': '1', 23:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:59 INFO - 'NO_EM_RESTART': '1', 23:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:59 INFO - 'PWD': '/builds/slave/test', 23:30:59 INFO - 'SHELL': '/bin/bash', 23:30:59 INFO - 'SHLVL': '1', 23:30:59 INFO - 'TERM': 'linux', 23:30:59 INFO - 'TMOUT': '86400', 23:30:59 INFO - 'USER': 'cltbld', 23:30:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', 23:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:59 INFO - '_': '/tools/buildbot/bin/python'} 23:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:59 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 23:30:59 INFO - Cleaning up... 23:30:59 INFO - Return code: 0 23:30:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6f6086cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f117d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0640>, '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 0x1fa1540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa19d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', '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 23:30:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 23:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:30:59 INFO - Using env: {'DISPLAY': ':0', 23:30:59 INFO - 'HOME': '/home/cltbld', 23:30:59 INFO - 'LANG': 'en_US.UTF-8', 23:30:59 INFO - 'LANGUAGE': 'en_US:en', 23:30:59 INFO - 'LOGNAME': 'cltbld', 23:30:59 INFO - 'MAIL': '/var/mail/cltbld', 23:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:59 INFO - 'MOZ_NO_REMOTE': '1', 23:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:59 INFO - 'NO_EM_RESTART': '1', 23:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:59 INFO - 'PWD': '/builds/slave/test', 23:30:59 INFO - 'SHELL': '/bin/bash', 23:30:59 INFO - 'SHLVL': '1', 23:30:59 INFO - 'TERM': 'linux', 23:30:59 INFO - 'TMOUT': '86400', 23:30:59 INFO - 'USER': 'cltbld', 23:30:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', 23:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:59 INFO - '_': '/tools/buildbot/bin/python'} 23:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:59 INFO - Downloading/unpacking psutil>=0.7.1 23:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:31:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:31:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:31:01 INFO - Installing collected packages: psutil 23:31:01 INFO - Running setup.py install for psutil 23:31:01 INFO - building 'psutil._psutil_linux' extension 23:31:01 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 23:31:02 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 23:31:02 INFO - building 'psutil._psutil_posix' extension 23:31:02 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 23:31:02 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 23:31:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:31:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:31:02 INFO - Successfully installed psutil 23:31:02 INFO - Cleaning up... 23:31:02 INFO - Return code: 0 23:31:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:31:02 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')]} 23:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:02 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')]} 23:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:02 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6f6086cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f117d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0640>, '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 0x1fa1540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa19d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', '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 23:31:02 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.0.0'] in /builds/slave/test/build 23:31:02 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.0.0 23:31:02 INFO - Using env: {'DISPLAY': ':0', 23:31:02 INFO - 'HOME': '/home/cltbld', 23:31:02 INFO - 'LANG': 'en_US.UTF-8', 23:31:02 INFO - 'LANGUAGE': 'en_US:en', 23:31:02 INFO - 'LOGNAME': 'cltbld', 23:31:02 INFO - 'MAIL': '/var/mail/cltbld', 23:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:02 INFO - 'MOZ_NO_REMOTE': '1', 23:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:02 INFO - 'NO_EM_RESTART': '1', 23:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:02 INFO - 'PWD': '/builds/slave/test', 23:31:02 INFO - 'SHELL': '/bin/bash', 23:31:02 INFO - 'SHLVL': '1', 23:31:02 INFO - 'TERM': 'linux', 23:31:02 INFO - 'TMOUT': '86400', 23:31:02 INFO - 'USER': 'cltbld', 23:31:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', 23:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:02 INFO - '_': '/tools/buildbot/bin/python'} 23:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:31:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:31:02 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 23:31:02 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 23:31:02 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 23:31:02 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 23:31:02 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 23:31:02 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 23:31:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:31:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:31:04 INFO - Installing collected packages: mozsystemmonitor 23:31:04 INFO - Running setup.py install for mozsystemmonitor 23:31:04 INFO - Successfully installed mozsystemmonitor 23:31:04 INFO - Cleaning up... 23:31:04 INFO - Return code: 0 23:31:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:31:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:31:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:04 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 0x7f6f6086cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f117d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0640>, '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 0x1fa1540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa19d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', '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 23:31:04 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 23:31:04 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 23:31:04 INFO - Using env: {'DISPLAY': ':0', 23:31:04 INFO - 'HOME': '/home/cltbld', 23:31:04 INFO - 'LANG': 'en_US.UTF-8', 23:31:04 INFO - 'LANGUAGE': 'en_US:en', 23:31:04 INFO - 'LOGNAME': 'cltbld', 23:31:04 INFO - 'MAIL': '/var/mail/cltbld', 23:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:04 INFO - 'MOZ_NO_REMOTE': '1', 23:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:04 INFO - 'NO_EM_RESTART': '1', 23:31:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:04 INFO - 'PWD': '/builds/slave/test', 23:31:04 INFO - 'SHELL': '/bin/bash', 23:31:04 INFO - 'SHLVL': '1', 23:31:04 INFO - 'TERM': 'linux', 23:31:04 INFO - 'TMOUT': '86400', 23:31:04 INFO - 'USER': 'cltbld', 23:31:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', 23:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:04 INFO - '_': '/tools/buildbot/bin/python'} 23:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:31:04 INFO - Downloading/unpacking blobuploader==1.2.4 23:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:31:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:31:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:31:06 INFO - Downloading blobuploader-1.2.4.tar.gz 23:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:31:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:31:06 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 23:31:06 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 23:31:06 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 23:31:06 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 23:31:06 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 23:31:06 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 23:31:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:31:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:31:07 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 23:31:07 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 23:31:07 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 23:31:07 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 23:31:07 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 23:31:07 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 23:31:07 INFO - Downloading docopt-0.6.1.tar.gz 23:31:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:31:07 INFO - Installing collected packages: blobuploader, requests, docopt 23:31:07 INFO - Running setup.py install for blobuploader 23:31:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:31:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:31:07 INFO - Running setup.py install for requests 23:31:08 INFO - Running setup.py install for docopt 23:31:08 INFO - Successfully installed blobuploader requests docopt 23:31:08 INFO - Cleaning up... 23:31:08 INFO - Return code: 0 23:31:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:31:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:31:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:08 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 0x7f6f6086cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f117d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0640>, '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 0x1fa1540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa19d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', '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 23:31:08 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 23:31:08 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 23:31:08 INFO - Using env: {'DISPLAY': ':0', 23:31:08 INFO - 'HOME': '/home/cltbld', 23:31:08 INFO - 'LANG': 'en_US.UTF-8', 23:31:08 INFO - 'LANGUAGE': 'en_US:en', 23:31:08 INFO - 'LOGNAME': 'cltbld', 23:31:08 INFO - 'MAIL': '/var/mail/cltbld', 23:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:08 INFO - 'MOZ_NO_REMOTE': '1', 23:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:08 INFO - 'NO_EM_RESTART': '1', 23:31:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:08 INFO - 'PWD': '/builds/slave/test', 23:31:08 INFO - 'SHELL': '/bin/bash', 23:31:08 INFO - 'SHLVL': '1', 23:31:08 INFO - 'TERM': 'linux', 23:31:08 INFO - 'TMOUT': '86400', 23:31:08 INFO - 'USER': 'cltbld', 23:31:08 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', 23:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:08 INFO - '_': '/tools/buildbot/bin/python'} 23:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:31:08 INFO - Running setup.py (path:/tmp/pip-ZpFgvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:31:08 INFO - Running setup.py (path:/tmp/pip-M0nuYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:31:08 INFO - Running setup.py (path:/tmp/pip-fg5eeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:31:08 INFO - Running setup.py (path:/tmp/pip-k2Ohct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:31:08 INFO - Running setup.py (path:/tmp/pip-LHny8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:31:08 INFO - Running setup.py (path:/tmp/pip-sPEi8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:31:08 INFO - Running setup.py (path:/tmp/pip-h7XKOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:31:08 INFO - Running setup.py (path:/tmp/pip-6ivk74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:31:08 INFO - Running setup.py (path:/tmp/pip-Foc7Fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:31:09 INFO - Running setup.py (path:/tmp/pip-qAUxLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:31:09 INFO - Running setup.py (path:/tmp/pip-S5o18x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:31:09 INFO - Running setup.py (path:/tmp/pip-_ClbmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:31:09 INFO - Running setup.py (path:/tmp/pip-WKlOJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:31:09 INFO - Running setup.py (path:/tmp/pip-LxRtpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:31:09 INFO - Running setup.py (path:/tmp/pip-gY3yo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:31:09 INFO - Running setup.py (path:/tmp/pip-4C6_55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:31:09 INFO - Running setup.py (path:/tmp/pip-05XEYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:31:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:31:09 INFO - Running setup.py install for manifestparser 23:31:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:31:09 INFO - Running setup.py install for mozcrash 23:31:09 INFO - Running setup.py install for mozdebug 23:31:09 INFO - Running setup.py install for mozdevice 23:31:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:31:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:31:10 INFO - Running setup.py install for mozfile 23:31:10 INFO - Running setup.py install for mozhttpd 23:31:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:31:10 INFO - Running setup.py install for mozinfo 23:31:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:31:10 INFO - Running setup.py install for mozInstall 23:31:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:31:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:31:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:31:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:31:10 INFO - Running setup.py install for mozleak 23:31:10 INFO - Running setup.py install for mozlog 23:31:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:31:10 INFO - Running setup.py install for moznetwork 23:31:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:31:10 INFO - Running setup.py install for mozprocess 23:31:10 INFO - Running setup.py install for mozprofile 23:31:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:31:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:31:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:31:10 INFO - Running setup.py install for mozrunner 23:31:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:31:11 INFO - Running setup.py install for mozscreenshot 23:31:11 INFO - Running setup.py install for moztest 23:31:11 INFO - Running setup.py install for mozversion 23:31:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:31:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:31:11 INFO - Cleaning up... 23:31:11 INFO - Return code: 0 23:31:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:31:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:31:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:31:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:11 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 0x7f6f6086cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f117d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0640>, '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 0x1fa1540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa19d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', '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 23:31:11 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 23:31:11 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 23:31:11 INFO - Using env: {'DISPLAY': ':0', 23:31:11 INFO - 'HOME': '/home/cltbld', 23:31:11 INFO - 'LANG': 'en_US.UTF-8', 23:31:11 INFO - 'LANGUAGE': 'en_US:en', 23:31:11 INFO - 'LOGNAME': 'cltbld', 23:31:11 INFO - 'MAIL': '/var/mail/cltbld', 23:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:11 INFO - 'MOZ_NO_REMOTE': '1', 23:31:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:11 INFO - 'NO_EM_RESTART': '1', 23:31:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:11 INFO - 'PWD': '/builds/slave/test', 23:31:11 INFO - 'SHELL': '/bin/bash', 23:31:11 INFO - 'SHLVL': '1', 23:31:11 INFO - 'TERM': 'linux', 23:31:11 INFO - 'TMOUT': '86400', 23:31:11 INFO - 'USER': 'cltbld', 23:31:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', 23:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:11 INFO - '_': '/tools/buildbot/bin/python'} 23:31:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:31:11 INFO - Running setup.py (path:/tmp/pip-4DHVuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:31:11 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)) 23:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:31:11 INFO - Running setup.py (path:/tmp/pip-fyzP3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:31:11 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)) 23:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:31:11 INFO - Running setup.py (path:/tmp/pip-anIal7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:31:11 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)) 23:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:31:11 INFO - Running setup.py (path:/tmp/pip-0PVIXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:31:11 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)) 23:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:31:11 INFO - Running setup.py (path:/tmp/pip-MIZeue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:31:11 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)) 23:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:31:11 INFO - Running setup.py (path:/tmp/pip-zRPw5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:31:12 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)) 23:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:31:12 INFO - Running setup.py (path:/tmp/pip-TZN8A5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:31:12 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)) 23:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:31:12 INFO - Running setup.py (path:/tmp/pip-AdsIUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:31:12 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)) 23:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:31:12 INFO - Running setup.py (path:/tmp/pip-2PmjHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:31:12 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)) 23:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:31:12 INFO - Running setup.py (path:/tmp/pip-WK4RcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:31:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 23:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:31:12 INFO - Running setup.py (path:/tmp/pip-wqwa4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:31:12 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)) 23:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:31:12 INFO - Running setup.py (path:/tmp/pip-sl2tGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:31:12 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)) 23:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:31:12 INFO - Running setup.py (path:/tmp/pip-KHj_vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:31:12 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)) 23:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:31:12 INFO - Running setup.py (path:/tmp/pip-rhlZrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:31:12 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)) 23:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:31:12 INFO - Running setup.py (path:/tmp/pip-z6sdpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:31:12 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)) 23:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:31:12 INFO - Running setup.py (path:/tmp/pip-HelkuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:31:12 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)) 23:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:31:12 INFO - Running setup.py (path:/tmp/pip-PjjfSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:31:12 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)) 23:31:12 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)) 23:31:12 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)) 23:31:12 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)) 23:31:12 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)) 23:31:12 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)) 23:31:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:31:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:31:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:31:14 INFO - Downloading blessings-1.6.tar.gz 23:31:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:31:14 INFO - Installing collected packages: blessings 23:31:14 INFO - Running setup.py install for blessings 23:31:14 INFO - Successfully installed blessings 23:31:14 INFO - Cleaning up... 23:31:14 INFO - Return code: 0 23:31:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:31:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:31:15 INFO - Reading from file tmpfile_stdout 23:31:15 INFO - Current package versions: 23:31:15 INFO - argparse == 1.2.1 23:31:15 INFO - blessings == 1.6 23:31:15 INFO - blobuploader == 1.2.4 23:31:15 INFO - docopt == 0.6.1 23:31:15 INFO - manifestparser == 1.1 23:31:15 INFO - mozInstall == 1.12 23:31:15 INFO - mozcrash == 0.17 23:31:15 INFO - mozdebug == 0.1 23:31:15 INFO - mozdevice == 0.48 23:31:15 INFO - mozfile == 1.2 23:31:15 INFO - mozhttpd == 0.7 23:31:15 INFO - mozinfo == 0.9 23:31:15 INFO - mozleak == 0.1 23:31:15 INFO - mozlog == 3.1 23:31:15 INFO - moznetwork == 0.27 23:31:15 INFO - mozprocess == 0.22 23:31:15 INFO - mozprofile == 0.28 23:31:15 INFO - mozrunner == 6.11 23:31:15 INFO - mozscreenshot == 0.1 23:31:15 INFO - mozsystemmonitor == 0.0 23:31:15 INFO - moztest == 0.7 23:31:15 INFO - mozversion == 1.4 23:31:15 INFO - psutil == 3.1.1 23:31:15 INFO - requests == 1.2.3 23:31:15 INFO - wsgiref == 0.1.2 23:31:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:15 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 0x7f6f6086cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f117d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0640>, '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 0x1fa1540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa19d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', '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 23:31:15 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 23:31:15 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 23:31:15 INFO - Using env: {'DISPLAY': ':0', 23:31:15 INFO - 'HOME': '/home/cltbld', 23:31:15 INFO - 'LANG': 'en_US.UTF-8', 23:31:15 INFO - 'LANGUAGE': 'en_US:en', 23:31:15 INFO - 'LOGNAME': 'cltbld', 23:31:15 INFO - 'MAIL': '/var/mail/cltbld', 23:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:15 INFO - 'MOZ_NO_REMOTE': '1', 23:31:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:15 INFO - 'NO_EM_RESTART': '1', 23:31:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:15 INFO - 'PWD': '/builds/slave/test', 23:31:15 INFO - 'SHELL': '/bin/bash', 23:31:15 INFO - 'SHLVL': '1', 23:31:15 INFO - 'TERM': 'linux', 23:31:15 INFO - 'TMOUT': '86400', 23:31:15 INFO - 'USER': 'cltbld', 23:31:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', 23:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:15 INFO - '_': '/tools/buildbot/bin/python'} 23:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:31:15 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)) 23:31:15 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)) 23:31:15 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)) 23:31:15 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)) 23:31:15 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)) 23:31:15 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)) 23:31:15 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)) 23:31:15 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)) 23:31:15 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)) 23:31:15 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)) 23:31:15 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)) 23:31:15 INFO - Cleaning up... 23:31:15 INFO - Return code: 0 23:31:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:15 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 0x7f6f6086cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f117d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0640>, '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 0x1fa1540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa19d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', '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 23:31:15 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 23:31:15 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 23:31:15 INFO - Using env: {'DISPLAY': ':0', 23:31:15 INFO - 'HOME': '/home/cltbld', 23:31:15 INFO - 'LANG': 'en_US.UTF-8', 23:31:15 INFO - 'LANGUAGE': 'en_US:en', 23:31:15 INFO - 'LOGNAME': 'cltbld', 23:31:15 INFO - 'MAIL': '/var/mail/cltbld', 23:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:15 INFO - 'MOZ_NO_REMOTE': '1', 23:31:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:15 INFO - 'NO_EM_RESTART': '1', 23:31:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:15 INFO - 'PWD': '/builds/slave/test', 23:31:15 INFO - 'SHELL': '/bin/bash', 23:31:15 INFO - 'SHLVL': '1', 23:31:15 INFO - 'TERM': 'linux', 23:31:15 INFO - 'TMOUT': '86400', 23:31:15 INFO - 'USER': 'cltbld', 23:31:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', 23:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:15 INFO - '_': '/tools/buildbot/bin/python'} 23:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:31:15 INFO - Downloading/unpacking jsonschema 23:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:31:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:31:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:31:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:31:17 INFO - Downloading/unpacking functools32 (from jsonschema) 23:31:17 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 23:31:17 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 23:31:17 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 23:31:17 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 23:31:17 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 23:31:17 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 23:31:17 INFO - Downloading functools32-3.2.3-2.tar.gz 23:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:31:17 INFO - warning: no files found matching '*.txt' 23:31:17 INFO - no previously-included directories found matching 'build' 23:31:17 INFO - no previously-included directories found matching 'dist' 23:31:17 INFO - no previously-included directories found matching '.git*' 23:31:17 INFO - Installing collected packages: jsonschema, functools32 23:31:17 INFO - Running setup.py install for functools32 23:31:17 INFO - warning: no files found matching '*.txt' 23:31:17 INFO - no previously-included directories found matching 'build' 23:31:17 INFO - no previously-included directories found matching 'dist' 23:31:17 INFO - no previously-included directories found matching '.git*' 23:31:17 INFO - Successfully installed jsonschema functools32 23:31:17 INFO - Cleaning up... 23:31:17 INFO - Return code: 0 23:31:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:31:17 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')]} 23:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:17 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')]} 23:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:17 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 0x7f6f6086cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f117d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0640>, '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 0x1fa1540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa19d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', '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 23:31:17 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 23:31:17 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 23:31:17 INFO - Using env: {'DISPLAY': ':0', 23:31:17 INFO - 'HOME': '/home/cltbld', 23:31:17 INFO - 'LANG': 'en_US.UTF-8', 23:31:17 INFO - 'LANGUAGE': 'en_US:en', 23:31:17 INFO - 'LOGNAME': 'cltbld', 23:31:17 INFO - 'MAIL': '/var/mail/cltbld', 23:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:17 INFO - 'MOZ_NO_REMOTE': '1', 23:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:17 INFO - 'NO_EM_RESTART': '1', 23:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:17 INFO - 'PWD': '/builds/slave/test', 23:31:17 INFO - 'SHELL': '/bin/bash', 23:31:17 INFO - 'SHLVL': '1', 23:31:17 INFO - 'TERM': 'linux', 23:31:17 INFO - 'TMOUT': '86400', 23:31:17 INFO - 'USER': 'cltbld', 23:31:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', 23:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:17 INFO - '_': '/tools/buildbot/bin/python'} 23:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:31:18 INFO - Downloading/unpacking flake8 23:31:18 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 23:31:18 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 23:31:18 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 23:31:18 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 23:31:18 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 23:31:18 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 23:31:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:31:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:31:20 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 23:31:20 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 23:31:20 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 23:31:20 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 23:31:20 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 23:31:20 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 23:31:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:31:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:31:20 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 23:31:20 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 23:31:20 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 23:31:20 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 23:31:20 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 23:31:20 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 23:31:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:31:20 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 23:31:20 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 23:31:20 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 23:31:20 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 23:31:20 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 23:31:20 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 23:31:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:31:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:31:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:31:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:31:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:31:20 INFO - no previously-included directories found matching 'docs/_build' 23:31:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:31:20 INFO - Running setup.py install for pep8 23:31:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:31:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:31:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:31:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:31:20 INFO - no previously-included directories found matching 'docs/_build' 23:31:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:31:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:31:20 INFO - Cleaning up... 23:31:20 INFO - Return code: 0 23:31:20 INFO - Running post-action listener: _resource_record_post_action 23:31:20 INFO - Running post-action listener: _start_resource_monitoring 23:31:21 INFO - Starting resource monitoring. 23:31:21 INFO - ##### 23:31:21 INFO - ##### Running install step. 23:31:21 INFO - ##### 23:31:21 INFO - Running pre-action listener: _resource_record_pre_action 23:31:21 INFO - Running main action method: install 23:31:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:31:21 INFO - Reading from file tmpfile_stdout 23:31:21 INFO - Detecting whether we're running mozinstall >=1.0... 23:31:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:31:21 INFO - Reading from file tmpfile_stdout 23:31:21 INFO - Output received: 23:31:21 INFO - Usage: mozinstall [options] installer 23:31:21 INFO - Options: 23:31:21 INFO - -h, --help show this help message and exit 23:31:21 INFO - -d DEST, --destination=DEST 23:31:21 INFO - Directory to install application into. [default: 23:31:21 INFO - "/builds/slave/test"] 23:31:21 INFO - --app=APP Application being installed. [default: firefox] 23:31:21 INFO - mkdir: /builds/slave/test/build/application 23:31:21 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'] 23:31:21 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 23:31:37 INFO - Reading from file tmpfile_stdout 23:31:37 INFO - Output received: 23:31:37 INFO - /builds/slave/test/build/application/firefox/firefox 23:31:37 INFO - Running post-action listener: _resource_record_post_action 23:31:37 INFO - ##### 23:31:37 INFO - ##### Running run-tests step. 23:31:37 INFO - ##### 23:31:37 INFO - Running pre-action listener: _resource_record_pre_action 23:31:37 INFO - Running main action method: run_tests 23:31:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:31:37 INFO - Python 2.7.3 23:31:37 INFO - Return code: 0 23:31:37 INFO - grabbing minidump binary from tooltool 23:31:37 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')]} 23:31:37 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa0640>, '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 0x1fa1540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa19d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:31:37 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 23:31:37 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 23:31:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:31:37 INFO - Return code: 0 23:31:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:31:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:31:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:31:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:31:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:31:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:31:38 INFO - Return code: 0 23:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 23:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 23:31:38 INFO - Using env: {'DISPLAY': ':0', 23:31:38 INFO - 'HOME': '/home/cltbld', 23:31:38 INFO - 'LANG': 'en_US.UTF-8', 23:31:38 INFO - 'LANGUAGE': 'en_US:en', 23:31:38 INFO - 'LOGNAME': 'cltbld', 23:31:38 INFO - 'MAIL': '/var/mail/cltbld', 23:31:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:31:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:38 INFO - 'MOZ_NO_REMOTE': '1', 23:31:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:38 INFO - 'NO_EM_RESTART': '1', 23:31:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:38 INFO - 'PWD': '/builds/slave/test', 23:31:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:31:38 INFO - 'SHELL': '/bin/bash', 23:31:38 INFO - 'SHLVL': '1', 23:31:38 INFO - 'TERM': 'linux', 23:31:38 INFO - 'TMOUT': '86400', 23:31:38 INFO - 'USER': 'cltbld', 23:31:38 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005', 23:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:38 INFO - '_': '/tools/buildbot/bin/python'} 23:31:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 23:31:39 INFO - mozversion application_buildid: 20160428203144 23:31:39 INFO - mozversion application_changeset: 0e049ed7092053c46c959e9e2e276fce84a13870 23:31:39 INFO - mozversion application_display_name: Nightly 23:31:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:31:39 INFO - mozversion application_name: Firefox 23:31:39 INFO - mozversion application_remotingname: firefox 23:31:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:31:39 INFO - mozversion application_vendor: Mozilla 23:31:39 INFO - mozversion application_version: 49.0a1 23:31:39 INFO - mozversion platform_buildid: 20160428203144 23:31:39 INFO - mozversion platform_changeset: 0e049ed7092053c46c959e9e2e276fce84a13870 23:31:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:31:39 INFO - mozversion platform_version: 49.0a1 23:31:39 INFO - using testdate: 1461911499 23:31:39 INFO - actual date: 1461911499 23:31:39 INFO - starting webserver on 'localhost:58441' 23:31:39 INFO - SUITE-START | Running 2 tests 23:31:39 INFO - TEST-START | dromaeo_css 23:31:39 INFO - operating with platform_type : linux_ 23:31:39 INFO - Initialising browser for dromaeo_css test... 23:31:39 INFO - TEST-INFO | started process 20632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYfCJjI/profile http://localhost:58441/getInfo.html) 23:31:42 INFO - PROCESS | 20632 | 23:31:42 INFO - PROCESS | 20632 | (process:20700): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:31:43 INFO - PROCESS | 20632 | __metrics Screen width/height:1600/1200 23:31:43 INFO - PROCESS | 20632 | colorDepth:24 23:31:43 INFO - PROCESS | 20632 | Browser inner width/height: 1024/697 23:31:43 INFO - PROCESS | 20632 | __metrics 23:31:44 ERROR - PROCESS | 20632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 23:31:45 INFO - TEST-INFO | 20632: exit 0 23:31:45 INFO - Browser initialized. 23:31:45 INFO - Running cycle 1/1 for dromaeo_css test... 23:31:45 INFO - TEST-INFO | started process 20751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYfCJjI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:31:47 INFO - PROCESS | 20751 | 23:31:47 INFO - PROCESS | 20751 | (process:20813): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:31:57 INFO - PROCESS | 20751 | RSS: Main: 164933632 23:31:57 INFO - PROCESS | 20751 | 23:32:46 INFO - PROCESS | 20751 | 1461911566692 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] 23:34:54 INFO - PROCESS | 20751 | Cycle 1(1): loaded http://localhost:58441/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58441/tests/dromaeo/cssquery-ext.html) 23:34:55 INFO - PROCESS | 20751 | RSS: Main: 169381888 23:34:55 INFO - PROCESS | 20751 | 23:37:57 INFO - PROCESS | 20751 | Cycle 1(1): loaded http://localhost:58441/tests/dromaeo/cssquery-ext.html (next: http://localhost:58441/tests/dromaeo/cssquery-jquery.html) 23:37:58 INFO - PROCESS | 20751 | RSS: Main: 166408192 23:37:58 INFO - PROCESS | 20751 | 23:40:59 INFO - PROCESS | 20751 | Cycle 1(1): loaded http://localhost:58441/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58441/tests/dromaeo/cssquery-mootools.html) 23:41:00 INFO - PROCESS | 20751 | RSS: Main: 167407616 23:41:00 INFO - PROCESS | 20751 | 23:44:02 INFO - PROCESS | 20751 | Cycle 1(1): loaded http://localhost:58441/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58441/tests/dromaeo/cssquery-prototype.html) 23:44:02 INFO - PROCESS | 20751 | RSS: Main: 165089280 23:44:02 INFO - PROCESS | 20751 | 23:47:05 INFO - PROCESS | 20751 | Cycle 1(1): loaded http://localhost:58441/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58441/tests/dromaeo/cssquery-yui.html) 23:47:05 INFO - PROCESS | 20751 | RSS: Main: 165916672 23:47:05 INFO - PROCESS | 20751 | 23:50:08 INFO - PROCESS | 20751 | Cycle 1(1): loaded http://localhost:58441/tests/dromaeo/cssquery-yui.html (next: http://localhost:58441/tests/dromaeo/cssquery-dojo.html) 23:50:08 INFO - PROCESS | 20751 | RSS: Main: 168132608 23:50:08 INFO - PROCESS | 20751 | 23:50:08 INFO - PROCESS | 20751 | __start_tp_report 23:50:08 INFO - PROCESS | 20751 | _x_x_mozilla_page_load 23:50:08 INFO - PROCESS | 20751 | _x_x_mozilla_page_load_details 23:50:08 INFO - PROCESS | 20751 | |i|pagename|runs| 23:50:08 INFO - PROCESS | 20751 | |0;dojo.html;3104.4256812489684;3135.7021082997107;3146.496560550311;3183.4747266700997;3188.8724451021944;5416.1604951232575;5478.178273259013;5485.725713714313;5499.780008799653;5510.256115424417;5363.141897296433;5389.110796718537;5426.240326354304;5455.345358556969;5493.340799104113;4909.607231421487;4952.702837829724;5021.246812978065;5037.949620503785;5064.417591976915;844.22509831557;4954.925676114861;5026.673266237701;5038.571721403685;5061.9240711389175;4979.8008079676765;5016.523430274118;5022.321986531826;5026.195808670614;5055.620828437864;4895.143349913751;5028.170351891933;5091.312672789163;5100.591952643779;5115.2071428928575;4968.577670897978;5007.924881126786;5008.424031236418;5010.223415370623;5060.063888180698;5408.783648654049;5418.566514678816;5425.6202065855405;5432;5523.392426833045;5693.3452652945025;5819.738111784937;5913.586048976574;5926.814637072603;5939.70301484924;5831.300243970751;5844.649321040752;5856.092305692582;5872.765089396419;5911;5436.592255580807;5442.510174084312;5446.1558458439;5457.863553411157;5465.890682186374;5815.9709201453725;5936.317323507766;5959.5828292020005;5963.463288304073;6020.729067191987;5652.293463317085;5655.491005809415;5663.178839068394;5671.51792097668;5683.318001839806;5732.541396688255;5735.1684005818925;5741.5119714824705;5761;5774.335951365562;5575.888482230333;5796.913046304308;5828.417158284137;5846.269216347957;5879.353271140171;5711.914321285184;5756.539476841843;5760.769569217185;5820.796272130539;5916.26046744157;4390.868273951786;4408.58118478744;4431.8448854289945;4433;4453.821847126143;3826.598207188261;3906.824192911326;3920.196359746245;3953.347697629916;3987.80060996949;5492.423295553989;5552;5559.027170245191;5561.332640083216;5563.916541251884;5804.738786754606;5807.5063619591965;5849.795257165979;5880.617759845596;5920.5559583031445;5399.352077750616;5586.748596313176;5596.300462442195;5609.5792815539;5665.036943719578;5017.322661440732;5028.84913452597;5046.318746969112;5071.036503064406;5107.131787596118;5863.970680146572;6083.908741368883;6113.663748493786;6123.173371594778;6126.846828829315;5691.0609749391715;5866.50134738552;5919.6744179070565;5941.910871336847;5973.193618861398;6039.939600603938;6080.48315893154;6097.969510152421;6100.694965251809;6112.572119951561;5544.944550554605;5793.913091303718;5795.565332600157;5799;5822.534197264294;5706.372299047019;5851.356350801323;5902.793402230901;5930.940690593211;5964.821055368346;5696.1455781633085;5722.198892155185;5728.570357223141;5733.111367738007;5740.167675687086;5482.068048431696;5714.571407144564;5730.054541000688;5735.598508104393;5760.94239057604;5652.293463317085;5708.143778433268;5733.770649174153;5737.512311453406;5760.308762948473;5754.971225143848;5771.653700777967;5779.682117483579;5784.82645520635;5805.216295800013;5474.452554744653;5611.3266408031295;5677.971610141923;5695.515881149983;5718.628289161191 23:50:08 INFO - PROCESS | 20751 | |1;ext.html;597.0804960361045;654.2312782480585;668.5754545863375;676.3169199108902;681.4412182010747;36965.63034369655;38185;38349.23301533975;38390.424143637865;38484.23031539371;41107.38338924918;41683.37474937871;41998;41998.58001419985;42165.367519487234;8646.351523635736;8828.24959878411;8832.823343533157;8840.55797210137;8844.204021638052;8709.390342676015;8821.867671984925;8831.646734130627;8834.160754728322;8836.911630883706;8862.33532485063;8866.512341821197;8899.733008009738;8913.1086891311;8939.64241430342;8778.2099611035;8799.296056315512;8828.911710882872;8835.204831565126;8837.779055523599;8564.715292706082;8744.73765787021;8773.517456539888;8780;8796.25231855293;28924.855375723197;39145.608543914765;39430.40854387187;39657.611983580435;39731.60268397337;3421.5723034620673;3461.3685657704737;3575.3743094958277;3970.7617542947514;4165.729227600196;28959.13122606325;29029.41941161165;29359.70640293591;29551.556726649116;30077.248068798453;3857.996920800612;3864.768113913174;3901.843926242947;3978.3833505806647;4187.309093999486;212426;213549;214031;215388;215778;48016.75991620089;54125;55343.44656553383;55544.72227638836;55701;58163.709181454666;58214;58308.41691583115;58448.954286600616;58650.70674646599;15545.145017023946;15579.29893154788;15622.218889055503;15739.370425182864;15744;13034.739305213843;13088.672783180496;13096.148750331198;13223.867761322455;13232;18877.22156545235;19093.427197184108;19287.421377358703;19353.612927741367;19371.709424358647;7318;7340.816479588053;7450.813729656694;7468.178500364956;7519.699212031457;1117.7648698188548;1161.8505764335912;1175.3887978251262;1231.2489381477471;1248.1076030638137;31518.684813152035;32015.83992080025;32032.359352812815;32194;32597;1163.4648061891626;1168.2231316174648;1211.2974474804769;1236.9876301237052;1275.8150068240054;16507.66984660324;16536.421225257058;16599.336026559045;16719.582010449834;17132.314707411813;433243;437721;438633;438688;474595;57749.711251444314;58608;59217;59222.40777592169;59226.40773592295;1477.541961991786;1487.4496436318632;1492.9178895160871;1494.5292232946588;1500.7598784194477;32064.358712825146;33585.496217557244;34441.31117377588;34684.47973280352;34700;53575.732121340705;54048.91902162013;55536;55665.443345566026;55755.16367254576;483323;484124;485922;488810;493734;45470;45833.541664582925;45982.310265345375;46193.53806461892;46444.7677761609;43584.78207608942;48983.36598824349;49365.75317123391;49387.50612493829;50573.49426505688;36568.63431365652;37201.0699732498;37327.06682332963;37521.437178441796;37670;39043.609563904;40963;41044.79477602593;41188.58811411847;41553.67570594406;34604.341963188315;38944.61055389523;39400.077447797026;39975.600243997185;41384.37923431091;33459.49810752792;35817.46273805947;35820.820895896395;36403.45394819027;36531.26937461289;28025.859870700515;28608.14175574736;28758.281042974093;28803.711962880105;28856.422871542873 23:50:08 INFO - PROCESS | 20751 | |2;jquery.html;378.536293041025;388.80365415465184;390.8163163313243;396.071213005502;396.4212250114832;17351;18654.906725466353;19512;19585.99999999998;19707.113179906904;18696.3173314402;18734.718979215322;18850.528736781587;19140;19472.70790938137;5541.695206763637;5631.4087020862835;5663.886722265553;5689.573282003846;5746.051901436258;5628.32460104788;5728.398518155596;5735.885282294352;5751.482366587006;5757.481826635602;5349.197620356938;5700.857478563028;5711.914321285184;5728.513076388512;5742.712864356787;5492.368377636583;5620.522255608278;5656.2364080849175;5660.830175094754;5671;5579.0515612346;5671.574631902624;5673.773049078032;5676.3188417389765;5676.403977582336;20901.790982090137;21013.47466313339;21139.3658190253;21939.67090493644;22075.448113797123;2209.9668504972437;2276.9544609107893;2363.0902102690416;2412.7949124324277;2538.936526586832;9641.951790241073;9703.563339649661;10194.337368071052;10272.691819245434;10554.894451055468;1860.479065861561;2026.7770545240012;2042;2052.989735051315;2058.7220725202055;62580;72491;74652.62673686596;83424.58287708584;87165.56417217937;10274.33216840903;10556.47217639115;10734.141268698486;10778.892211077946;10894.564217431373;14329.6417589559;14363.712725745427;14405.567832965027;14436.422543098159;14505.709885802225;7822.374210063182;7973.880391794128;8073.6770529178175;8115.147909469539;8317.251447369767;7410.296021877913;7506.662200201004;7880.605969701492;7977.920220797718;7985.920140798517;4640.95359046412;4677.321788340671;4699.671023028423;4763.142634325785;4854.417469903634;1877.2021890696399;1945.5369442392564;1972.8323092537296;1998.060911371653;2004.0881398963436;453.9024109816405;457.7413761224897;947.2895328503622;1077.7251800790748;1095.2869771474707;11370;11606;11606.129540284512;11648.184627076023;11669.416529173677;458.8806910203371;466.2423561712218;471.4837253207801;485.221219941988;495.96776209546266;6226;6246.625202487865;6322.272938612118;6336;6351;503317;511857;521278;531003;531047;78137;95291;97388;98232.50883745536;99670;473.8673171511982;474.926386410107;477.9307000484841;485.2357536879429;486.91965825638374;11509.366984815915;11534.769304613694;11544.480498377761;11574.88425115738;11703;40593.797031014656;41273.79363103285;41671.58328416677;41697.583024170584;43075.56924430715;56849.14726279192;58315.958941436846;58628.4137158623;58751.41248587459;59434.81130377282;8669.089745576875;8725.301975842045;8764.91235087641;8793.120687931156;8823.514706690938;9725.6596019139;12472.314022728837;13380.464781408635;13799.586012419644;13895.124158238508;12163.574274900337;12174.330411827434;12282.263064216175;12429;12560.811587826372;11910.34493102853;12235.204711693712;12301;12322.199057061262;12453.93773031129;12382.752344953231;12460.875391246334;12472.126951113334;12711.682207944876;12746.808797867854;8584.270337021424;8722.869156962777;8738.25724813398;8914.242289405473;9021.774455638662;11470.541178352772;11886.286822790315;12013.579524716593;12043.397830108635;12133.635990920286 23:50:08 INFO - PROCESS | 20751 | |3;mootools.html;1508.5097343363402;1529.1666042007105;1650.2326418215528;1776.1652023548943;1802.540352210187;6981.616011119387;7928.326092282163;8003.559804210766;8282.42023058386;8348.874766878502;8158.388120890927;8162.428629995903;8229.753107406787;8242.629081691322;8260.05009423915;2266.150193677367;2298.6322188449853;2300.056976639578;2309.861408315498;2313.849599776009;2292.106078629336;2300.0454811253308;2307.630779075348;2315.409570559505;2316.81465482761;2262.479629685173;2285.8399912006166;2296.219285442949;2312.2369618026096;2319.083961835074;2241.0587553227683;2245.640697488394;2246.034205291724;2246.135237933391;2252.6170551006367;2187.1907394264067;2193.9890300548554;2201.7137772089686;2228.576570451609;2244.9663255051187;8347.29048030918;8399.454035487674;8423.536705481196;8438.156184381574;8442.197991190827;4860.416749990024;4966.627502937258;4977.925331120036;4982.676126051795;4987.15218412867;3161.5573819665265;3232.8383580820864;3417.572803399575;3427.5715535558056;3434.107132145635;1060.5598676549223;1066.9253152279343;1079.3200283821143;1082.112667612558;1084.804735147673;11070.28043177191;11139.33164010162;11184.328940263611;11202.103831693445;11219.439028048564;4398.186335527937;4460.531644177379;4523.344115103291;4563.908721825611;4575.771211439414;9610.759731006781;9631.422114673142;9650.95174524123;9651.662191823252;9678.854817177747;4948.777305021283;5002.449730529639;5036.370453693288;5037.622178336639;5040.84877453677;3904.511936007999;4406.471223453142;4485.282354823213;4524.276115821453;4524.977375113103;3896.8441262349756;3953.3872249801325;3985.80070996449;4000.579939106352;4057.959420405817;1259.924404535731;1264.7217612125319;1267.473998290699;1273.6879464531064;1282.5895713371817;963.1620490173594;971.140540621555;996.4220751963844;1004.5128112865254;1039.7452624107143;5674.943250567524;5921.111833224964;6107.603005804608;6111.388861113942;6184.536159788034;442.2238970606565;444.755384538509;461.7670818913509;466.7572862111751;472.70007479431564;3993.9001524961527;4175.91648167035;4197.412362269285;4221.6833737469815;4226.323788193874;10083.092521673085;10543.57825686964;10657.413842238751;10666.41334726582;10683.626073087406;9830.21358291335;10262.640807571699;10507.94746026265;10515.211359148094;10515.947420263003;7738;7969.242921922408;8057.717979870677;8092.352611791042;8098.919010809935;6025.276966764016;6078.179445774941;6261.467775238973;6267.2479302484;6403.455706265019;9590.232781377334;9640.373375730554;9671.032896710272;9673.1294183521;9703.223742100474;9837.803243934937;9954;9971.800563988534;10029.799404012025;10077.244206684381;6629.635370054693;7342.192358840416;7621.31408173267;7641.42689298316;7766.534007959541;8179.018517777905;8209.917900820916;8228.547429891414;8255.876161857457;8272.751817445485;7307.3423391894985;7333.376662983706;7373.078365204349;7432;7612.200718924433;7126.429885609243;7360.1535823381;7375.631218439164;7426.997355356958;7460.4031677466755;6523.575967562093;6877;6886.10480637514;6918.135233095863;6926.480513961373;4966.056449274626;5038.697678139323;5088.872778180576;5110.284560161655;5190.480951904779;5117.437081920912;5182.689038657692;5220.347456567929;5220.399654039834;5291.9206211906085 23:50:08 INFO - PROCESS | 20751 | |4;prototype.html;302.5537332434659;315.4290733771873;317.1943264109163;319.07150192938553;320.44243017150166;5410.864728381783;5504.2018907258525;5510.448955104487;5552.750126244318;5644.830655080344;5524.364698059724;5530.972345138279;5585.916211256835;5586.385497595272;5599.720013999304;4290.570942905708;4291.806868690901;4298.570142985708;4319.725680924119;4324.54592267812;4163;4310.612044915957;4311.116221174668;4324.13517296542;4353.62994145498;4204;4245.448091748084;4265.978670106645;4270.57294270572;4284.6786491013145;4255.063885945087;4256.170046840867;4256.93576605847;4267.231898258312;4283.7429754214845;3712.0905378182247;3781.243751249761;3783.564890037653;3807.1053302473897;3813.180166264239;5352.518273355417;5353.625246232766;5386.272853164812;5386.649867758622;5387.838364849022;4877.975610121926;4891.825961769186;4907.533784290486;4907.975460122677;4933.580645645125;5584.179989105516;5779.33537643168;5796.188533605298;5829.154772557998;5842.678652674102;4131.256373852705;4139.317012692902;4150.460440142762;4155.189738001091;4155.293600087993;6014.51883849291;6014.909776353358;6044.395560443921;6044.909326360064;6074.754675291555;4086.6526345260986;4141.275276826544;4213.599708027732;4225.492940847056;4231.809568569422;4171.749695018309;4198.6641068714425;4210;4217.936730949038;4219.113986062961;4761.262004389325;4793.18515852299;4818.10864989978;4826.95173048272;4861.927071093936;5694.4590263924865;5778;5848.239728835224;5873.353931067579;5901.144334071621;1578.7710781936785;1585.8414158584048;1588.7210795309886;1594.0196778980844;1595.4734937470607;1057.1701214546545;1059.3802625464036;1071.3250652089134;1078.978420431587;1088.3469918049266;6015.127806468037;6018.969905150446;6031.4270144336215;6038.728257228435;6042.365551617105;6423.871522569522;6444.871102577922;6462.192225971754;6462.676866156768;6469.150855241124;5799.39106393831;5978;5981.20563830849;5991.610545314541;6010.879782404415;3451.551298331201;3453.188500702333;3454.844531996016;3470.496777967231;3474.4093504103857;6586.4401525870835;6659.766908158192;6690.765823196165;6712.019954113548;6752.392284694303;6525.445337146396;6584.539082264291;6603.712276106209;6626.05140712388;6634.303398143222;6463.935360646427;6529.2817790043055;6634.568753031038;6648.069270302161;6682.431993280626;6348.809535713936;6399.456046236122;6446.8388290293115;6461.57999730016;6461.870762584816;5689.886202276014;6378.425941665272;6381.840453988501;6383;6396.520260980352;6209.689515524115;6256.874862502816;6260.686965651608;6285.497160227263;6292.52806039558;3836.4628951946193;4016.859409920639;4078.5309689384912;4091.6726661867574;4128.876133715993;5954.583179177416;5995;6016.2479690038745;6031.306399763907;6037.27552693662;5756.481916627356;5791.710414479175;5835.9708201458725;5839.510924714171;5871.970640146772;5770.5095066919785;5813.360530341574;5832.504237139721;5850;5886.3525012247765;5706;5739.167820666064;5747.36778954323;5753.4246575343805;5762.711864406847;5668.51817595509;5818.854528636818;5827.708614569339;5864.32560255559;5872.0898260769645;5660.547156227574;5760.308762948473;5784;5790.855228619318;5791.565632577658 23:50:08 INFO - PROCESS | 20751 | |5;yui.html;763.8014116329753;764.293028948223;828.6146941672122;833.5123952487794;845.1464021338446;11934.343611101385;12258.632241032761;12264.386780660976;12267.570635027765;12272.07959403045;12306.38468076597;12327.26036437812;12342.629721108358;12364.690882727937;12432.12975091744;661.9073329733841;770.660909199953;793.2583034862394;795.5624406576388;797.9162187970267;803.5138741061661;804.1837534902079;807.2129673568253;807.8303556253194;809.3161278719502;854.5428195915187;858.0775666158873;858.51064893011;859.1794835931702;861.1001503428901;852.5907564369076;853.3685073045932;854.6538651846013;855.9657613695445;857.8756080368374;621.1614320667063;623.4139908486054;623.6227082614998;627.2598333965918;627.5607075047485;12029.338386388745;12134.878651213552;12160.087993400442;12184.451699673536;12206.450709718085;13725.245111518863;13892.861071389258;13949.163050216917;14120.223387713671;14239.145651260958;10843.728906777314;11090.722731931686;11154.609588664358;11389.373584452851;11462.94268528652;3823.0824602095577;3837.597052309523;3868.2456920900436;3895.474110995036;4033.3748269018347;53258.20112698313;53357.466425336024;53905.460945390434;54390.728046359516;54399.18401223985;11247.268927519684;11263.098952083814;11304.491297891615;11388.316700997966;11464.25482343645;20165.899170504053;20212.191512339636;20238.19047238094;20257.898710506353;20261.290854820305;8157.836843263101;8339.54132522705;8384.16158384169;8412.484389537529;8568.742937711879;4826.493218212107;4827.179379505493;4838.419389673261;4858.319835223072;4911.508849115131;3279.6556361582166;3394.372041172391;3397.11674964511;3400.472926696366;3401.608814986308;611.2878496551557;613.3222788818381;618.5144661440747;624.5440828195352;633.1990032608753;624.073251221935;662.6289278004236;754.9355408873462;757.8484303139394;770.2836362183111;9179;9215.216706580015;9473.28950328728;9480.241580673668;9563.521823908915;562.6286650810446;587.9235699359056;593.6022864680674;714.8463080437731;781.5115552779513;4238.809253583596;4493.505714371417;4743.857684269408;4918.0901533216465;5071.4928507149725;63442.0483692745;64458;66862.66568667223;67093;67622.32377676161;57573.4242657568;58052.419475805546;58062;58674.41325586775;60932;53640.46359536433;53766.19350709742;54249;54466.72766636142;55536.64044469796;9615.471149086588;9793.657221997197;9794.971527989743;9896.802063958825;9906.455144966807;35416.64583354237;35591.11022224465;35683.46474802828;35928.101797455274;36217.45673814842;46435.30347044865;47027.76486117548;47652;47701;47737.52262477331;12193.26840389544;12315.75368492643;12599.685007874876;12733.490660373482;12845.972322214388;13696.726065478833;13759.17444953306;13886.72226555443;14347.784783228468;14511.927440362731;12130.150889437655;12672.87327126717;13026.413811378321;13031.869681303066;13046;12800.871991279968;13107.606771796862;13127.212367257995;13419.463221471422;13538;12727.172733772646;12782.169159004636;12840.101192916407;12865.485380584672;12940.741185176432;10457.320274182153;10832.350058996486;11069.501872415922;11070.944645276722;11141.55159829217;11213.66359009231;11271.774564508827;11303.1522635801;11350.318980861175;11386.487608057823 23:50:08 INFO - PROCESS | 20751 | __end_tp_report 23:50:08 INFO - PROCESS | 20751 | __start_cc_report 23:50:08 INFO - PROCESS | 20751 | _x_x_mozilla_cycle_collect,342 23:50:08 INFO - PROCESS | 20751 | __end_cc_report 23:50:08 INFO - PROCESS | 20751 | __startTimestamp1461912608523__endTimestamp 23:50:08 INFO - PROCESS | 20751 | 23:50:08 INFO - PROCESS | 20751 | ------- Summary: start ------- 23:50:08 INFO - PROCESS | 20751 | Number of tests: 6 23:50:08 INFO - PROCESS | 20751 | 23:50:08 INFO - PROCESS | 20751 | [#0] dojo.html Cycles:165 Average:5406.61 Median:5665.04 stddev:714.43 (12.6%) stddev-sans-first:693.42 23:50:08 INFO - PROCESS | 20751 | Values: 3104.4 3135.7 3146.5 3183.5 3188.9 5416.2 5478.2 5485.7 5499.8 5510.3 5363.1 5389.1 5426.2 5455.3 5493.3 4909.6 4952.7 5021.2 5037.9 5064.4 844.2 4954.9 5026.7 5038.6 5061.9 4979.8 5016.5 5022.3 5026.2 5055.6 4895.1 5028.2 5091.3 5100.6 5115.2 4968.6 5007.9 5008.4 5010.2 5060.1 5408.8 5418.6 5425.6 5432.0 5523.4 5693.3 5819.7 5913.6 5926.8 5939.7 5831.3 5844.6 5856.1 5872.8 5911.0 5436.6 5442.5 5446.2 5457.9 5465.9 5816.0 5936.3 5959.6 5963.5 6020.7 5652.3 5655.5 5663.2 5671.5 5683.3 5732.5 5735.2 5741.5 5761.0 5774.3 5575.9 5796.9 5828.4 5846.3 5879.4 5711.9 5756.5 5760.8 5820.8 5916.3 4390.9 4408.6 4431.8 4433.0 4453.8 3826.6 3906.8 3920.2 3953.3 3987.8 5492.4 5552.0 5559.0 5561.3 5563.9 5804.7 5807.5 5849.8 5880.6 5920.6 5399.4 5586.7 5596.3 5609.6 5665.0 5017.3 5028.8 5046.3 5071.0 5107.1 5864.0 6083.9 6113.7 6123.2 6126.8 5691.1 5866.5 5919.7 5941.9 5973.2 6039.9 6080.5 6098.0 6100.7 6112.6 5544.9 5793.9 5795.6 5799.0 5822.5 5706.4 5851.4 5902.8 5930.9 5964.8 5696.1 5722.2 5728.6 5733.1 5740.2 5482.1 5714.6 5730.1 5735.6 5760.9 5652.3 5708.1 5733.8 5737.5 5760.3 5755.0 5771.7 5779.7 5784.8 5805.2 5474.5 5611.3 5678.0 5695.5 5718.6 23:50:08 INFO - PROCESS | 20751 | 23:50:08 INFO - PROCESS | 20751 | [#1] ext.html Cycles:180 Average:55229.13 Median:21854.99 stddev:106285.29 (486.3%) stddev-sans-first:106504.30 23:50:08 INFO - PROCESS | 20751 | Values: 597.1 654.2 668.6 676.3 681.4 36965.6 38185.0 38349.2 38390.4 38484.2 41107.4 41683.4 41998.0 41998.6 42165.4 8646.4 8828.2 8832.8 8840.6 8844.2 8709.4 8821.9 8831.6 8834.2 8836.9 8862.3 8866.5 8899.7 8913.1 8939.6 8778.2 8799.3 8828.9 8835.2 8837.8 8564.7 8744.7 8773.5 8780.0 8796.3 28924.9 39145.6 39430.4 39657.6 39731.6 3421.6 3461.4 3575.4 3970.8 4165.7 28959.1 29029.4 29359.7 29551.6 30077.2 3858.0 3864.8 3901.8 3978.4 4187.3 212426.0 213549.0 214031.0 215388.0 215778.0 48016.8 54125.0 55343.4 55544.7 55701.0 58163.7 58214.0 58308.4 58449.0 58650.7 15545.1 15579.3 15622.2 15739.4 15744.0 13034.7 13088.7 13096.1 13223.9 13232.0 18877.2 19093.4 19287.4 19353.6 19371.7 7318.0 7340.8 7450.8 7468.2 7519.7 1117.8 1161.9 1175.4 1231.2 1248.1 31518.7 32015.8 32032.4 32194.0 32597.0 1163.5 1168.2 1211.3 1237.0 1275.8 16507.7 16536.4 16599.3 16719.6 17132.3 433243.0 437721.0 438633.0 438688.0 474595.0 57749.7 58608.0 59217.0 59222.4 59226.4 1477.5 1487.4 1492.9 1494.5 1500.8 32064.4 33585.5 34441.3 34684.5 34700.0 53575.7 54048.9 55536.0 55665.4 55755.2 483323.0 484124.0 485922.0 488810.0 493734.0 45470.0 45833.5 45982.3 46193.5 46444.8 43584.8 48983.4 49365.8 49387.5 50573.5 36568.6 37201.1 37327.1 37521.4 37670.0 39043.6 40963.0 41044.8 41188.6 41553.7 34604.3 38944.6 39400.1 39975.6 41384.4 33459.5 35817.5 35820.8 36403.5 36531.3 28025.9 28608.1 28758.3 28803.7 28856.4 23:50:08 INFO - PROCESS | 20751 | 23:50:08 INFO - PROCESS | 20751 | [#2] jquery.html Cycles:180 Average:29168.14 Median:458.31 stddev:85643.60 (18686.8%) stddev-sans-first:85856.57 23:50:08 INFO - PROCESS | 20751 | Values: 378.5 388.8 390.8 396.1 396.4 17351.0 18654.9 19512.0 19586.0 19707.1 18696.3 18734.7 18850.5 19140.0 19472.7 5541.7 5631.4 5663.9 5689.6 5746.1 5628.3 5728.4 5735.9 5751.5 5757.5 5349.2 5700.9 5711.9 5728.5 5742.7 5492.4 5620.5 5656.2 5660.8 5671.0 5579.1 5671.6 5673.8 5676.3 5676.4 20901.8 21013.5 21139.4 21939.7 22075.4 2210.0 2277.0 2363.1 2412.8 2538.9 9642.0 9703.6 10194.3 10272.7 10554.9 1860.5 2026.8 2042.0 2053.0 2058.7 62580.0 72491.0 74652.6 83424.6 87165.6 10274.3 10556.5 10734.1 10778.9 10894.6 14329.6 14363.7 14405.6 14436.4 14505.7 7822.4 7973.9 8073.7 8115.1 8317.3 7410.3 7506.7 7880.6 7977.9 7985.9 4641.0 4677.3 4699.7 4763.1 4854.4 1877.2 1945.5 1972.8 1998.1 2004.1 453.9 457.7 947.3 1077.7 1095.3 11370.0 11606.0 11606.1 11648.2 11669.4 458.9 466.2 471.5 485.2 496.0 6226.0 6246.6 6322.3 6336.0 6351.0 503317.0 511857.0 521278.0 531003.0 531047.0 78137.0 95291.0 97388.0 98232.5 99670.0 473.9 474.9 477.9 485.2 486.9 11509.4 11534.8 11544.5 11574.9 11703.0 40593.8 41273.8 41671.6 41697.6 43075.6 56849.1 58316.0 58628.4 58751.4 59434.8 8669.1 8725.3 8764.9 8793.1 8823.5 9725.7 12472.3 13380.5 13799.6 13895.1 12163.6 12174.3 12282.3 12429.0 12560.8 11910.3 12235.2 12301.0 12322.2 12453.9 12382.8 12460.9 12472.1 12711.7 12746.8 8584.3 8722.9 8738.3 8914.2 9021.8 11470.5 11886.3 12013.6 12043.4 12133.6 23:50:08 INFO - PROCESS | 20751 | 23:50:08 INFO - PROCESS | 20751 | [#3] mootools.html Cycles:180 Average:5573.53 Median:4966.34 stddev:3109.43 (62.6%) stddev-sans-first:3103.15 23:50:08 INFO - PROCESS | 20751 | Values: 1508.5 1529.2 1650.2 1776.2 1802.5 6981.6 7928.3 8003.6 8282.4 8348.9 8158.4 8162.4 8229.8 8242.6 8260.1 2266.2 2298.6 2300.1 2309.9 2313.8 2292.1 2300.0 2307.6 2315.4 2316.8 2262.5 2285.8 2296.2 2312.2 2319.1 2241.1 2245.6 2246.0 2246.1 2252.6 2187.2 2194.0 2201.7 2228.6 2245.0 8347.3 8399.5 8423.5 8438.2 8442.2 4860.4 4966.6 4977.9 4982.7 4987.2 3161.6 3232.8 3417.6 3427.6 3434.1 1060.6 1066.9 1079.3 1082.1 1084.8 11070.3 11139.3 11184.3 11202.1 11219.4 4398.2 4460.5 4523.3 4563.9 4575.8 9610.8 9631.4 9651.0 9651.7 9678.9 4948.8 5002.4 5036.4 5037.6 5040.8 3904.5 4406.5 4485.3 4524.3 4525.0 3896.8 3953.4 3985.8 4000.6 4058.0 1259.9 1264.7 1267.5 1273.7 1282.6 963.2 971.1 996.4 1004.5 1039.7 5674.9 5921.1 6107.6 6111.4 6184.5 442.2 444.8 461.8 466.8 472.7 3993.9 4175.9 4197.4 4221.7 4226.3 10083.1 10543.6 10657.4 10666.4 10683.6 9830.2 10262.6 10507.9 10515.2 10515.9 7738.0 7969.2 8057.7 8092.4 8098.9 6025.3 6078.2 6261.5 6267.2 6403.5 9590.2 9640.4 9671.0 9673.1 9703.2 9837.8 9954.0 9971.8 10029.8 10077.2 6629.6 7342.2 7621.3 7641.4 7766.5 8179.0 8209.9 8228.5 8255.9 8272.8 7307.3 7333.4 7373.1 7432.0 7612.2 7126.4 7360.2 7375.6 7427.0 7460.4 6523.6 6877.0 6886.1 6918.1 6926.5 4966.1 5038.7 5088.9 5110.3 5190.5 5117.4 5182.7 5220.3 5220.4 5291.9 23:50:08 INFO - PROCESS | 20751 | 23:50:08 INFO - PROCESS | 20751 | [#4] prototype.html Cycles:180 Average:4996.99 Median:5652.69 stddev:1518.16 (26.9%) stddev-sans-first:1480.96 23:50:08 INFO - PROCESS | 20751 | Values: 302.6 315.4 317.2 319.1 320.4 5410.9 5504.2 5510.4 5552.8 5644.8 5524.4 5531.0 5585.9 5586.4 5599.7 4290.6 4291.8 4298.6 4319.7 4324.5 4163.0 4310.6 4311.1 4324.1 4353.6 4204.0 4245.4 4266.0 4270.6 4284.7 4255.1 4256.2 4256.9 4267.2 4283.7 3712.1 3781.2 3783.6 3807.1 3813.2 5352.5 5353.6 5386.3 5386.6 5387.8 4878.0 4891.8 4907.5 4908.0 4933.6 5584.2 5779.3 5796.2 5829.2 5842.7 4131.3 4139.3 4150.5 4155.2 4155.3 6014.5 6014.9 6044.4 6044.9 6074.8 4086.7 4141.3 4213.6 4225.5 4231.8 4171.7 4198.7 4210.0 4217.9 4219.1 4761.3 4793.2 4818.1 4827.0 4861.9 5694.5 5778.0 5848.2 5873.4 5901.1 1578.8 1585.8 1588.7 1594.0 1595.5 1057.2 1059.4 1071.3 1079.0 1088.3 6015.1 6019.0 6031.4 6038.7 6042.4 6423.9 6444.9 6462.2 6462.7 6469.2 5799.4 5978.0 5981.2 5991.6 6010.9 3451.6 3453.2 3454.8 3470.5 3474.4 6586.4 6659.8 6690.8 6712.0 6752.4 6525.4 6584.5 6603.7 6626.1 6634.3 6463.9 6529.3 6634.6 6648.1 6682.4 6348.8 6399.5 6446.8 6461.6 6461.9 5689.9 6378.4 6381.8 6383.0 6396.5 6209.7 6256.9 6260.7 6285.5 6292.5 3836.5 4016.9 4078.5 4091.7 4128.9 5954.6 5995.0 6016.2 6031.3 6037.3 5756.5 5791.7 5836.0 5839.5 5872.0 5770.5 5813.4 5832.5 5850.0 5886.4 5706.0 5739.2 5747.4 5753.4 5762.7 5668.5 5818.9 5827.7 5864.3 5872.1 5660.5 5760.3 5784.0 5790.9 5791.6 23:50:08 INFO - PROCESS | 20751 | 23:50:08 INFO - PROCESS | 20751 | [#5] yui.html Cycles:180 Average:15220.33 Median:47676.50 stddev:17971.12 (37.7%) stddev-sans-first:17988.74 23:50:08 INFO - PROCESS | 20751 | Values: 763.8 764.3 828.6 833.5 845.1 11934.3 12258.6 12264.4 12267.6 12272.1 12306.4 12327.3 12342.6 12364.7 12432.1 661.9 770.7 793.3 795.6 797.9 803.5 804.2 807.2 807.8 809.3 854.5 858.1 858.5 859.2 861.1 852.6 853.4 854.7 856.0 857.9 621.2 623.4 623.6 627.3 627.6 12029.3 12134.9 12160.1 12184.5 12206.5 13725.2 13892.9 13949.2 14120.2 14239.1 10843.7 11090.7 11154.6 11389.4 11462.9 3823.1 3837.6 3868.2 3895.5 4033.4 53258.2 53357.5 53905.5 54390.7 54399.2 11247.3 11263.1 11304.5 11388.3 11464.3 20165.9 20212.2 20238.2 20257.9 20261.3 8157.8 8339.5 8384.2 8412.5 8568.7 4826.5 4827.2 4838.4 4858.3 4911.5 3279.7 3394.4 3397.1 3400.5 3401.6 611.3 613.3 618.5 624.5 633.2 624.1 662.6 754.9 757.8 770.3 9179.0 9215.2 9473.3 9480.2 9563.5 562.6 587.9 593.6 714.8 781.5 4238.8 4493.5 4743.9 4918.1 5071.5 63442.0 64458.0 66862.7 67093.0 67622.3 57573.4 58052.4 58062.0 58674.4 60932.0 53640.5 53766.2 54249.0 54466.7 55536.6 9615.5 9793.7 9795.0 9896.8 9906.5 35416.6 35591.1 35683.5 35928.1 36217.5 46435.3 47027.8 47652.0 47701.0 47737.5 12193.3 12315.8 12599.7 12733.5 12846.0 13696.7 13759.2 13886.7 14347.8 14511.9 12130.2 12672.9 13026.4 13031.9 13046.0 12800.9 13107.6 13127.2 13419.5 13538.0 12727.2 12782.2 12840.1 12865.5 12940.7 10457.3 10832.4 11069.5 11070.9 11141.6 11213.7 11271.8 11303.2 11350.3 11386.5 23:50:08 INFO - PROCESS | 20751 | -------- Summary: end -------- 23:50:08 INFO - PROCESS | 20751 | 23:50:09 INFO - TEST-INFO | 20751: exit 0 23:50:09 INFO - TEST-OK | dromaeo_css | took 1110119ms 23:50:09 INFO - TEST-START | kraken 23:50:09 INFO - operating with platform_type : linux_ 23:50:09 INFO - Initialising browser for kraken test... 23:50:09 INFO - TEST-INFO | started process 20980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt55O1O/profile http://localhost:58441/getInfo.html) 23:50:12 INFO - PROCESS | 20980 | 23:50:12 INFO - PROCESS | 20980 | (process:21051): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:50:13 INFO - PROCESS | 20980 | __metrics Screen width/height:1600/1200 23:50:13 INFO - PROCESS | 20980 | colorDepth:24 23:50:13 INFO - PROCESS | 20980 | Browser inner width/height: 1024/697 23:50:13 INFO - PROCESS | 20980 | __metrics 23:50:14 ERROR - PROCESS | 20980 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 23:50:15 INFO - TEST-INFO | 20980: exit 0 23:50:15 INFO - Browser initialized. 23:50:15 INFO - Running cycle 1/1 for kraken test... 23:50:15 INFO - TEST-INFO | started process 21102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt55O1O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:50:16 INFO - PROCESS | 21102 | 23:50:16 INFO - PROCESS | 21102 | (process:21167): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:50:26 INFO - PROCESS | 21102 | RSS: Main: 165101568 23:50:26 INFO - PROCESS | 21102 | 23:50:29 INFO - PROCESS | 21102 | Cycle 1(1): loaded http://localhost:58441/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58441/tests/kraken/driver.html?testName=audio-beat-detection) 23:50:30 INFO - PROCESS | 21102 | RSS: Main: 170024960 23:50:30 INFO - PROCESS | 21102 | 23:50:33 INFO - PROCESS | 21102 | Cycle 1(1): loaded http://localhost:58441/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58441/tests/kraken/driver.html?testName=audio-dft) 23:50:33 INFO - PROCESS | 21102 | RSS: Main: 172933120 23:50:33 INFO - PROCESS | 21102 | 23:50:36 INFO - PROCESS | 21102 | Cycle 1(1): loaded http://localhost:58441/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58441/tests/kraken/driver.html?testName=audio-fft) 23:50:37 INFO - PROCESS | 21102 | RSS: Main: 164589568 23:50:37 INFO - PROCESS | 21102 | 23:50:39 INFO - PROCESS | 21102 | Cycle 1(1): loaded http://localhost:58441/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58441/tests/kraken/driver.html?testName=audio-oscillator) 23:50:39 INFO - PROCESS | 21102 | RSS: Main: 164438016 23:50:39 INFO - PROCESS | 21102 | 23:50:42 INFO - PROCESS | 21102 | Cycle 1(1): loaded http://localhost:58441/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58441/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:50:42 INFO - PROCESS | 21102 | RSS: Main: 164839424 23:50:42 INFO - PROCESS | 21102 | 23:50:45 INFO - PROCESS | 21102 | Cycle 1(1): loaded http://localhost:58441/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58441/tests/kraken/driver.html?testName=imaging-darkroom) 23:50:46 INFO - PROCESS | 21102 | RSS: Main: 165568512 23:50:46 INFO - PROCESS | 21102 | 23:50:49 INFO - PROCESS | 21102 | Cycle 1(1): loaded http://localhost:58441/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58441/tests/kraken/driver.html?testName=imaging-desaturate) 23:50:50 INFO - PROCESS | 21102 | RSS: Main: 165498880 23:50:50 INFO - PROCESS | 21102 | 23:50:53 INFO - PROCESS | 21102 | Cycle 1(1): loaded http://localhost:58441/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58441/tests/kraken/driver.html?testName=json-parse-financial) 23:50:53 INFO - PROCESS | 21102 | RSS: Main: 167825408 23:50:53 INFO - PROCESS | 21102 | 23:50:55 INFO - PROCESS | 21102 | Cycle 1(1): loaded http://localhost:58441/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58441/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:50:55 INFO - PROCESS | 21102 | RSS: Main: 167460864 23:50:55 INFO - PROCESS | 21102 | 23:50:57 INFO - PROCESS | 21102 | Cycle 1(1): loaded http://localhost:58441/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58441/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:50:58 INFO - PROCESS | 21102 | RSS: Main: 167370752 23:50:58 INFO - PROCESS | 21102 | 23:51:00 INFO - PROCESS | 21102 | Cycle 1(1): loaded http://localhost:58441/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58441/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:51:01 INFO - PROCESS | 21102 | RSS: Main: 167833600 23:51:01 INFO - PROCESS | 21102 | 23:51:03 INFO - PROCESS | 21102 | Cycle 1(1): loaded http://localhost:58441/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:51:04 INFO - PROCESS | 21102 | RSS: Main: 168230912 23:51:04 INFO - PROCESS | 21102 | 23:51:07 INFO - PROCESS | 21102 | Cycle 1(1): loaded http://localhost:58441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:51:07 INFO - PROCESS | 21102 | RSS: Main: 168357888 23:51:07 INFO - PROCESS | 21102 | 23:51:09 INFO - PROCESS | 21102 | Cycle 1(1): loaded http://localhost:58441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58441/tests/kraken/driver.html?testName=ai-astar) 23:51:09 INFO - PROCESS | 21102 | RSS: Main: 169316352 23:51:09 INFO - PROCESS | 21102 | 23:51:09 INFO - PROCESS | 21102 | __start_tp_report 23:51:09 INFO - PROCESS | 21102 | _x_x_mozilla_page_load 23:51:09 INFO - PROCESS | 21102 | _x_x_mozilla_page_load_details 23:51:09 INFO - PROCESS | 21102 | |i|pagename|runs| 23:51:09 INFO - PROCESS | 21102 | |0;ai-astar;112;108;113;111;113;124;112;114;112;111 23:51:09 INFO - PROCESS | 21102 | |1;audio-beat-detection;163;131;155;186;127;158;163;130;179;132 23:51:09 INFO - PROCESS | 21102 | |2;audio-dft;163;165;163;163;164;168;178;164;167;163 23:51:09 INFO - PROCESS | 21102 | |3;audio-fft;77;73;75;157;76;74;76;77;167;73 23:51:09 INFO - PROCESS | 21102 | |4;audio-oscillator;91;93;148;93;92;92;151;94;91;144 23:51:09 INFO - PROCESS | 21102 | |5;imaging-gaussian-blur;117;118;117;118;118;117;118;118;118;117 23:51:09 INFO - PROCESS | 21102 | |6;imaging-darkroom;147;147;147;147;148;147;147;147;147;148 23:51:09 INFO - PROCESS | 21102 | |7;imaging-desaturate;95;96;95;95;95;95;96;95;95;95 23:51:09 INFO - PROCESS | 21102 | |8;json-parse-financial;58;58;58;57;59;59;58;77;57;56 23:51:09 INFO - PROCESS | 21102 | |9;json-stringify-tinderbox;60;62;60;61;62;60;60;61;62;60 23:51:09 INFO - PROCESS | 21102 | |10;stanford-crypto-aes;75;76;83;86;78;84;77;78;78;77 23:51:09 INFO - PROCESS | 21102 | |11;stanford-crypto-ccm;131;125;137;128;124;132;127;130;213;126 23:51:09 INFO - PROCESS | 21102 | |12;stanford-crypto-pbkdf2;177;173;192;170;167;170;171;166;166;171 23:51:09 INFO - PROCESS | 21102 | |13;stanford-crypto-sha256-iterative;70;72;70;69;70;68;67;66;70;68 23:51:09 INFO - PROCESS | 21102 | __end_tp_report 23:51:09 INFO - PROCESS | 21102 | __start_cc_report 23:51:09 INFO - PROCESS | 21102 | _x_x_mozilla_cycle_collect,845 23:51:09 INFO - PROCESS | 21102 | __end_cc_report 23:51:09 INFO - PROCESS | 21102 | __startTimestamp1461912669770__endTimestamp 23:51:09 INFO - PROCESS | 21102 | 23:51:09 INFO - PROCESS | 21102 | ------- Summary: start ------- 23:51:09 INFO - PROCESS | 21102 | Number of tests: 14 23:51:09 INFO - PROCESS | 21102 | 23:51:09 INFO - PROCESS | 21102 | [#0] ai-astar Cycles:10 Average:113.00 Median:112.50 stddev:4.19 (3.7%) stddev-sans-first:4.43 23:51:09 INFO - PROCESS | 21102 | Values: 112.0 108.0 113.0 111.0 113.0 124.0 112.0 114.0 112.0 111.0 23:51:09 INFO - PROCESS | 21102 | 23:51:09 INFO - PROCESS | 21102 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:160.50 stddev:21.40 (13.3%) stddev-sans-first:22.35 23:51:09 INFO - PROCESS | 21102 | Values: 163.0 131.0 155.0 186.0 127.0 158.0 163.0 130.0 179.0 132.0 23:51:09 INFO - PROCESS | 21102 | 23:51:09 INFO - PROCESS | 21102 | [#2] audio-dft Cycles:10 Average:165.80 Median:164.50 stddev:4.64 (2.8%) stddev-sans-first:4.81 23:51:09 INFO - PROCESS | 21102 | Values: 163.0 165.0 163.0 163.0 164.0 168.0 178.0 164.0 167.0 163.0 23:51:09 INFO - PROCESS | 21102 | 23:51:09 INFO - PROCESS | 21102 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.50 stddev:36.73 (48.7%) stddev-sans-first:38.53 23:51:09 INFO - PROCESS | 21102 | Values: 77.0 73.0 75.0 157.0 76.0 74.0 76.0 77.0 167.0 73.0 23:51:09 INFO - PROCESS | 21102 | 23:51:09 INFO - PROCESS | 21102 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:92.00 stddev:26.82 (29.2%) stddev-sans-first:27.65 23:51:09 INFO - PROCESS | 21102 | Values: 91.0 93.0 148.0 93.0 92.0 92.0 151.0 94.0 91.0 144.0 23:51:09 INFO - PROCESS | 21102 | 23:51:09 INFO - PROCESS | 21102 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 23:51:09 INFO - PROCESS | 21102 | Values: 117.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 118.0 117.0 23:51:09 INFO - PROCESS | 21102 | 23:51:09 INFO - PROCESS | 21102 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 23:51:09 INFO - PROCESS | 21102 | Values: 147.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 148.0 23:51:09 INFO - PROCESS | 21102 | 23:51:09 INFO - PROCESS | 21102 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:51:09 INFO - PROCESS | 21102 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 23:51:09 INFO - PROCESS | 21102 | 23:51:09 INFO - PROCESS | 21102 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:58.00 stddev:6.15 (10.6%) stddev-sans-first:6.49 23:51:09 INFO - PROCESS | 21102 | Values: 58.0 58.0 58.0 57.0 59.0 59.0 58.0 77.0 57.0 56.0 23:51:09 INFO - PROCESS | 21102 | 23:51:09 INFO - PROCESS | 21102 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.92 (1.5%) stddev-sans-first:0.93 23:51:09 INFO - PROCESS | 21102 | Values: 60.0 62.0 60.0 61.0 62.0 60.0 60.0 61.0 62.0 60.0 23:51:09 INFO - PROCESS | 21102 | 23:51:09 INFO - PROCESS | 21102 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:78.00 stddev:3.74 (4.8%) stddev-sans-first:3.64 23:51:09 INFO - PROCESS | 21102 | Values: 75.0 76.0 83.0 86.0 78.0 84.0 77.0 78.0 78.0 77.0 23:51:09 INFO - PROCESS | 21102 | 23:51:09 INFO - PROCESS | 21102 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:130.50 stddev:26.87 (20.6%) stddev-sans-first:28.41 23:51:09 INFO - PROCESS | 21102 | Values: 131.0 125.0 137.0 128.0 124.0 132.0 127.0 130.0 213.0 126.0 23:51:09 INFO - PROCESS | 21102 | 23:51:09 INFO - PROCESS | 21102 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:171.00 stddev:7.69 (4.5%) stddev-sans-first:7.97 23:51:09 INFO - PROCESS | 21102 | Values: 177.0 173.0 192.0 170.0 167.0 170.0 171.0 166.0 166.0 171.0 23:51:09 INFO - PROCESS | 21102 | 23:51:09 INFO - PROCESS | 21102 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:70.00 stddev:1.76 (2.5%) stddev-sans-first:1.83 23:51:09 INFO - PROCESS | 21102 | Values: 70.0 72.0 70.0 69.0 70.0 68.0 67.0 66.0 70.0 68.0 23:51:09 INFO - PROCESS | 21102 | -------- Summary: end -------- 23:51:09 INFO - PROCESS | 21102 | 23:51:10 INFO - TEST-INFO | 21102: exit 0 23:51:10 INFO - TEST-OK | kraken | took 61590ms 23:51:10 INFO - SUITE-END | took 1171s 23:51:10 INFO - Completed test suite (00:19:31) 23:51:10 INFO - javascript benchmark 23:51:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3104.4256812489684, 3135.7021082997107, 3146.496560550311, 3183.4747266700997, 3188.8724451021944, 5416.1604951232575, 5478.178273259013, 5485.725713714313, 5499.780008799653, 5510.256115424417, 5363.141897296433, 5389.110796718537, 5426.240326354304, 5455.345358556969, 5493.340799104113, 4909.607231421487, 4952.702837829724, 5021.246812978065, 5037.949620503785, 5064.417591976915, 844.22509831557, 4954.925676114861, 5026.673266237701, 5038.571721403685, 5061.9240711389175, 4979.8008079676765, 5016.523430274118, 5022.321986531826, 5026.195808670614, 5055.620828437864, 4895.143349913751, 5028.170351891933, 5091.312672789163, 5100.591952643779, 5115.2071428928575, 4968.577670897978, 5007.924881126786, 5008.424031236418, 5010.223415370623, 5060.063888180698, 5408.783648654049, 5418.566514678816, 5425.6202065855405, 5432.0, 5523.392426833045, 5693.3452652945025, 5819.738111784937, 5913.586048976574, 5926.814637072603, 5939.70301484924, 5831.300243970751, 5844.649321040752, 5856.092305692582, 5872.765089396419, 5911.0, 5436.592255580807, 5442.510174084312, 5446.1558458439, 5457.863553411157, 5465.890682186374, 5815.9709201453725, 5936.317323507766, 5959.5828292020005, 5963.463288304073, 6020.729067191987, 5652.293463317085, 5655.491005809415, 5663.178839068394, 5671.51792097668, 5683.318001839806, 5732.541396688255, 5735.1684005818925, 5741.5119714824705, 5761.0, 5774.335951365562, 5575.888482230333, 5796.913046304308, 5828.417158284137, 5846.269216347957, 5879.353271140171, 5711.914321285184, 5756.539476841843, 5760.769569217185, 5820.796272130539, 5916.26046744157, 4390.868273951786, 4408.58118478744, 4431.8448854289945, 4433.0, 4453.821847126143, 3826.598207188261, 3906.824192911326, 3920.196359746245, 3953.347697629916, 3987.80060996949, 5492.423295553989, 5552.0, 5559.027170245191, 5561.332640083216, 5563.916541251884, 5804.738786754606, 5807.5063619591965, 5849.795257165979, 5880.617759845596, 5920.5559583031445, 5399.352077750616, 5586.748596313176, 5596.300462442195, 5609.5792815539, 5665.036943719578, 5017.322661440732, 5028.84913452597, 5046.318746969112, 5071.036503064406, 5107.131787596118, 5863.970680146572, 6083.908741368883, 6113.663748493786, 6123.173371594778, 6126.846828829315, 5691.0609749391715, 5866.50134738552, 5919.6744179070565, 5941.910871336847, 5973.193618861398, 6039.939600603938, 6080.48315893154, 6097.969510152421, 6100.694965251809, 6112.572119951561, 5544.944550554605, 5793.913091303718, 5795.565332600157, 5799.0, 5822.534197264294, 5706.372299047019, 5851.356350801323, 5902.793402230901, 5930.940690593211, 5964.821055368346, 5696.1455781633085, 5722.198892155185, 5728.570357223141, 5733.111367738007, 5740.167675687086, 5482.068048431696, 5714.571407144564, 5730.054541000688, 5735.598508104393, 5760.94239057604, 5652.293463317085, 5708.143778433268, 5733.770649174153, 5737.512311453406, 5760.308762948473, 5754.971225143848, 5771.653700777967, 5779.682117483579, 5784.82645520635, 5805.216295800013, 5474.452554744653, 5611.3266408031295, 5677.971610141923, 5695.515881149983, 5718.628289161191], "value": 5360.067977861083, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.0804960361045, 654.2312782480585, 668.5754545863375, 676.3169199108902, 681.4412182010747, 36965.63034369655, 38185.0, 38349.23301533975, 38390.424143637865, 38484.23031539371, 41107.38338924918, 41683.37474937871, 41998.0, 41998.58001419985, 42165.367519487234, 8646.351523635736, 8828.24959878411, 8832.823343533157, 8840.55797210137, 8844.204021638052, 8709.390342676015, 8821.867671984925, 8831.646734130627, 8834.160754728322, 8836.911630883706, 8862.33532485063, 8866.512341821197, 8899.733008009738, 8913.1086891311, 8939.64241430342, 8778.2099611035, 8799.296056315512, 8828.911710882872, 8835.204831565126, 8837.779055523599, 8564.715292706082, 8744.73765787021, 8773.517456539888, 8780.0, 8796.25231855293, 28924.855375723197, 39145.608543914765, 39430.40854387187, 39657.611983580435, 39731.60268397337, 3421.5723034620673, 3461.3685657704737, 3575.3743094958277, 3970.7617542947514, 4165.729227600196, 28959.13122606325, 29029.41941161165, 29359.70640293591, 29551.556726649116, 30077.248068798453, 3857.996920800612, 3864.768113913174, 3901.843926242947, 3978.3833505806647, 4187.309093999486, 212426.0, 213549.0, 214031.0, 215388.0, 215778.0, 48016.75991620089, 54125.0, 55343.44656553383, 55544.72227638836, 55701.0, 58163.709181454666, 58214.0, 58308.41691583115, 58448.954286600616, 58650.70674646599, 15545.145017023946, 15579.29893154788, 15622.218889055503, 15739.370425182864, 15744.0, 13034.739305213843, 13088.672783180496, 13096.148750331198, 13223.867761322455, 13232.0, 18877.22156545235, 19093.427197184108, 19287.421377358703, 19353.612927741367, 19371.709424358647, 7318.0, 7340.816479588053, 7450.813729656694, 7468.178500364956, 7519.699212031457, 1117.7648698188548, 1161.8505764335912, 1175.3887978251262, 1231.2489381477471, 1248.1076030638137, 31518.684813152035, 32015.83992080025, 32032.359352812815, 32194.0, 32597.0, 1163.4648061891626, 1168.2231316174648, 1211.2974474804769, 1236.9876301237052, 1275.8150068240054, 16507.66984660324, 16536.421225257058, 16599.336026559045, 16719.582010449834, 17132.314707411813, 433243.0, 437721.0, 438633.0, 438688.0, 474595.0, 57749.711251444314, 58608.0, 59217.0, 59222.40777592169, 59226.40773592295, 1477.541961991786, 1487.4496436318632, 1492.9178895160871, 1494.5292232946588, 1500.7598784194477, 32064.358712825146, 33585.496217557244, 34441.31117377588, 34684.47973280352, 34700.0, 53575.732121340705, 54048.91902162013, 55536.0, 55665.443345566026, 55755.16367254576, 483323.0, 484124.0, 485922.0, 488810.0, 493734.0, 45470.0, 45833.541664582925, 45982.310265345375, 46193.53806461892, 46444.7677761609, 43584.78207608942, 48983.36598824349, 49365.75317123391, 49387.50612493829, 50573.49426505688, 36568.63431365652, 37201.0699732498, 37327.06682332963, 37521.437178441796, 37670.0, 39043.609563904, 40963.0, 41044.79477602593, 41188.58811411847, 41553.67570594406, 34604.341963188315, 38944.61055389523, 39400.077447797026, 39975.600243997185, 41384.37923431091, 33459.49810752792, 35817.46273805947, 35820.820895896395, 36403.45394819027, 36531.26937461289, 28025.859870700515, 28608.14175574736, 28758.281042974093, 28803.711962880105, 28856.422871542873], "value": 19963.30271810355, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.536293041025, 388.80365415465184, 390.8163163313243, 396.071213005502, 396.4212250114832, 17351.0, 18654.906725466353, 19512.0, 19585.99999999998, 19707.113179906904, 18696.3173314402, 18734.718979215322, 18850.528736781587, 19140.0, 19472.70790938137, 5541.695206763637, 5631.4087020862835, 5663.886722265553, 5689.573282003846, 5746.051901436258, 5628.32460104788, 5728.398518155596, 5735.885282294352, 5751.482366587006, 5757.481826635602, 5349.197620356938, 5700.857478563028, 5711.914321285184, 5728.513076388512, 5742.712864356787, 5492.368377636583, 5620.522255608278, 5656.2364080849175, 5660.830175094754, 5671.0, 5579.0515612346, 5671.574631902624, 5673.773049078032, 5676.3188417389765, 5676.403977582336, 20901.790982090137, 21013.47466313339, 21139.3658190253, 21939.67090493644, 22075.448113797123, 2209.9668504972437, 2276.9544609107893, 2363.0902102690416, 2412.7949124324277, 2538.936526586832, 9641.951790241073, 9703.563339649661, 10194.337368071052, 10272.691819245434, 10554.894451055468, 1860.479065861561, 2026.7770545240012, 2042.0, 2052.989735051315, 2058.7220725202055, 62580.0, 72491.0, 74652.62673686596, 83424.58287708584, 87165.56417217937, 10274.33216840903, 10556.47217639115, 10734.141268698486, 10778.892211077946, 10894.564217431373, 14329.6417589559, 14363.712725745427, 14405.567832965027, 14436.422543098159, 14505.709885802225, 7822.374210063182, 7973.880391794128, 8073.6770529178175, 8115.147909469539, 8317.251447369767, 7410.296021877913, 7506.662200201004, 7880.605969701492, 7977.920220797718, 7985.920140798517, 4640.95359046412, 4677.321788340671, 4699.671023028423, 4763.142634325785, 4854.417469903634, 1877.2021890696399, 1945.5369442392564, 1972.8323092537296, 1998.060911371653, 2004.0881398963436, 453.9024109816405, 457.7413761224897, 947.2895328503622, 1077.7251800790748, 1095.2869771474707, 11370.0, 11606.0, 11606.129540284512, 11648.184627076023, 11669.416529173677, 458.8806910203371, 466.2423561712218, 471.4837253207801, 485.221219941988, 495.96776209546266, 6226.0, 6246.625202487865, 6322.272938612118, 6336.0, 6351.0, 503317.0, 511857.0, 521278.0, 531003.0, 531047.0, 78137.0, 95291.0, 97388.0, 98232.50883745536, 99670.0, 473.8673171511982, 474.926386410107, 477.9307000484841, 485.2357536879429, 486.91965825638374, 11509.366984815915, 11534.769304613694, 11544.480498377761, 11574.88425115738, 11703.0, 40593.797031014656, 41273.79363103285, 41671.58328416677, 41697.583024170584, 43075.56924430715, 56849.14726279192, 58315.958941436846, 58628.4137158623, 58751.41248587459, 59434.81130377282, 8669.089745576875, 8725.301975842045, 8764.91235087641, 8793.120687931156, 8823.514706690938, 9725.6596019139, 12472.314022728837, 13380.464781408635, 13799.586012419644, 13895.124158238508, 12163.574274900337, 12174.330411827434, 12282.263064216175, 12429.0, 12560.811587826372, 11910.34493102853, 12235.204711693712, 12301.0, 12322.199057061262, 12453.93773031129, 12382.752344953231, 12460.875391246334, 12472.126951113334, 12711.682207944876, 12746.808797867854, 8584.270337021424, 8722.869156962777, 8738.25724813398, 8914.242289405473, 9021.774455638662, 11470.541178352772, 11886.286822790315, 12013.579524716593, 12043.397830108635, 12133.635990920286], "value": 8446.780530544847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.5097343363402, 1529.1666042007105, 1650.2326418215528, 1776.1652023548943, 1802.540352210187, 6981.616011119387, 7928.326092282163, 8003.559804210766, 8282.42023058386, 8348.874766878502, 8158.388120890927, 8162.428629995903, 8229.753107406787, 8242.629081691322, 8260.05009423915, 2266.150193677367, 2298.6322188449853, 2300.056976639578, 2309.861408315498, 2313.849599776009, 2292.106078629336, 2300.0454811253308, 2307.630779075348, 2315.409570559505, 2316.81465482761, 2262.479629685173, 2285.8399912006166, 2296.219285442949, 2312.2369618026096, 2319.083961835074, 2241.0587553227683, 2245.640697488394, 2246.034205291724, 2246.135237933391, 2252.6170551006367, 2187.1907394264067, 2193.9890300548554, 2201.7137772089686, 2228.576570451609, 2244.9663255051187, 8347.29048030918, 8399.454035487674, 8423.536705481196, 8438.156184381574, 8442.197991190827, 4860.416749990024, 4966.627502937258, 4977.925331120036, 4982.676126051795, 4987.15218412867, 3161.5573819665265, 3232.8383580820864, 3417.572803399575, 3427.5715535558056, 3434.107132145635, 1060.5598676549223, 1066.9253152279343, 1079.3200283821143, 1082.112667612558, 1084.804735147673, 11070.28043177191, 11139.33164010162, 11184.328940263611, 11202.103831693445, 11219.439028048564, 4398.186335527937, 4460.531644177379, 4523.344115103291, 4563.908721825611, 4575.771211439414, 9610.759731006781, 9631.422114673142, 9650.95174524123, 9651.662191823252, 9678.854817177747, 4948.777305021283, 5002.449730529639, 5036.370453693288, 5037.622178336639, 5040.84877453677, 3904.511936007999, 4406.471223453142, 4485.282354823213, 4524.276115821453, 4524.977375113103, 3896.8441262349756, 3953.3872249801325, 3985.80070996449, 4000.579939106352, 4057.959420405817, 1259.924404535731, 1264.7217612125319, 1267.473998290699, 1273.6879464531064, 1282.5895713371817, 963.1620490173594, 971.140540621555, 996.4220751963844, 1004.5128112865254, 1039.7452624107143, 5674.943250567524, 5921.111833224964, 6107.603005804608, 6111.388861113942, 6184.536159788034, 442.2238970606565, 444.755384538509, 461.7670818913509, 466.7572862111751, 472.70007479431564, 3993.9001524961527, 4175.91648167035, 4197.412362269285, 4221.6833737469815, 4226.323788193874, 10083.092521673085, 10543.57825686964, 10657.413842238751, 10666.41334726582, 10683.626073087406, 9830.21358291335, 10262.640807571699, 10507.94746026265, 10515.211359148094, 10515.947420263003, 7738.0, 7969.242921922408, 8057.717979870677, 8092.352611791042, 8098.919010809935, 6025.276966764016, 6078.179445774941, 6261.467775238973, 6267.2479302484, 6403.455706265019, 9590.232781377334, 9640.373375730554, 9671.032896710272, 9673.1294183521, 9703.223742100474, 9837.803243934937, 9954.0, 9971.800563988534, 10029.799404012025, 10077.244206684381, 6629.635370054693, 7342.192358840416, 7621.31408173267, 7641.42689298316, 7766.534007959541, 8179.018517777905, 8209.917900820916, 8228.547429891414, 8255.876161857457, 8272.751817445485, 7307.3423391894985, 7333.376662983706, 7373.078365204349, 7432.0, 7612.200718924433, 7126.429885609243, 7360.1535823381, 7375.631218439164, 7426.997355356958, 7460.4031677466755, 6523.575967562093, 6877.0, 6886.10480637514, 6918.135233095863, 6926.480513961373, 4966.056449274626, 5038.697678139323, 5088.872778180576, 5110.284560161655, 5190.480951904779, 5117.437081920912, 5182.689038657692, 5220.347456567929, 5220.399654039834, 5291.9206211906085], "value": 4428.746204395149, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.5537332434659, 315.4290733771873, 317.1943264109163, 319.07150192938553, 320.44243017150166, 5410.864728381783, 5504.2018907258525, 5510.448955104487, 5552.750126244318, 5644.830655080344, 5524.364698059724, 5530.972345138279, 5585.916211256835, 5586.385497595272, 5599.720013999304, 4290.570942905708, 4291.806868690901, 4298.570142985708, 4319.725680924119, 4324.54592267812, 4163.0, 4310.612044915957, 4311.116221174668, 4324.13517296542, 4353.62994145498, 4204.0, 4245.448091748084, 4265.978670106645, 4270.57294270572, 4284.6786491013145, 4255.063885945087, 4256.170046840867, 4256.93576605847, 4267.231898258312, 4283.7429754214845, 3712.0905378182247, 3781.243751249761, 3783.564890037653, 3807.1053302473897, 3813.180166264239, 5352.518273355417, 5353.625246232766, 5386.272853164812, 5386.649867758622, 5387.838364849022, 4877.975610121926, 4891.825961769186, 4907.533784290486, 4907.975460122677, 4933.580645645125, 5584.179989105516, 5779.33537643168, 5796.188533605298, 5829.154772557998, 5842.678652674102, 4131.256373852705, 4139.317012692902, 4150.460440142762, 4155.189738001091, 4155.293600087993, 6014.51883849291, 6014.909776353358, 6044.395560443921, 6044.909326360064, 6074.754675291555, 4086.6526345260986, 4141.275276826544, 4213.599708027732, 4225.492940847056, 4231.809568569422, 4171.749695018309, 4198.6641068714425, 4210.0, 4217.936730949038, 4219.113986062961, 4761.262004389325, 4793.18515852299, 4818.10864989978, 4826.95173048272, 4861.927071093936, 5694.4590263924865, 5778.0, 5848.239728835224, 5873.353931067579, 5901.144334071621, 1578.7710781936785, 1585.8414158584048, 1588.7210795309886, 1594.0196778980844, 1595.4734937470607, 1057.1701214546545, 1059.3802625464036, 1071.3250652089134, 1078.978420431587, 1088.3469918049266, 6015.127806468037, 6018.969905150446, 6031.4270144336215, 6038.728257228435, 6042.365551617105, 6423.871522569522, 6444.871102577922, 6462.192225971754, 6462.676866156768, 6469.150855241124, 5799.39106393831, 5978.0, 5981.20563830849, 5991.610545314541, 6010.879782404415, 3451.551298331201, 3453.188500702333, 3454.844531996016, 3470.496777967231, 3474.4093504103857, 6586.4401525870835, 6659.766908158192, 6690.765823196165, 6712.019954113548, 6752.392284694303, 6525.445337146396, 6584.539082264291, 6603.712276106209, 6626.05140712388, 6634.303398143222, 6463.935360646427, 6529.2817790043055, 6634.568753031038, 6648.069270302161, 6682.431993280626, 6348.809535713936, 6399.456046236122, 6446.8388290293115, 6461.57999730016, 6461.870762584816, 5689.886202276014, 6378.425941665272, 6381.840453988501, 6383.0, 6396.520260980352, 6209.689515524115, 6256.874862502816, 6260.686965651608, 6285.497160227263, 6292.52806039558, 3836.4628951946193, 4016.859409920639, 4078.5309689384912, 4091.6726661867574, 4128.876133715993, 5954.583179177416, 5995.0, 6016.2479690038745, 6031.306399763907, 6037.27552693662, 5756.481916627356, 5791.710414479175, 5835.9708201458725, 5839.510924714171, 5871.970640146772, 5770.5095066919785, 5813.360530341574, 5832.504237139721, 5850.0, 5886.3525012247765, 5706.0, 5739.167820666064, 5747.36778954323, 5753.4246575343805, 5762.711864406847, 5668.51817595509, 5818.854528636818, 5827.708614569339, 5864.32560255559, 5872.0898260769645, 5660.547156227574, 5760.308762948473, 5784.0, 5790.855228619318, 5791.565632577658], "value": 4512.236072648097, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.8014116329753, 764.293028948223, 828.6146941672122, 833.5123952487794, 845.1464021338446, 11934.343611101385, 12258.632241032761, 12264.386780660976, 12267.570635027765, 12272.07959403045, 12306.38468076597, 12327.26036437812, 12342.629721108358, 12364.690882727937, 12432.12975091744, 661.9073329733841, 770.660909199953, 793.2583034862394, 795.5624406576388, 797.9162187970267, 803.5138741061661, 804.1837534902079, 807.2129673568253, 807.8303556253194, 809.3161278719502, 854.5428195915187, 858.0775666158873, 858.51064893011, 859.1794835931702, 861.1001503428901, 852.5907564369076, 853.3685073045932, 854.6538651846013, 855.9657613695445, 857.8756080368374, 621.1614320667063, 623.4139908486054, 623.6227082614998, 627.2598333965918, 627.5607075047485, 12029.338386388745, 12134.878651213552, 12160.087993400442, 12184.451699673536, 12206.450709718085, 13725.245111518863, 13892.861071389258, 13949.163050216917, 14120.223387713671, 14239.145651260958, 10843.728906777314, 11090.722731931686, 11154.609588664358, 11389.373584452851, 11462.94268528652, 3823.0824602095577, 3837.597052309523, 3868.2456920900436, 3895.474110995036, 4033.3748269018347, 53258.20112698313, 53357.466425336024, 53905.460945390434, 54390.728046359516, 54399.18401223985, 11247.268927519684, 11263.098952083814, 11304.491297891615, 11388.316700997966, 11464.25482343645, 20165.899170504053, 20212.191512339636, 20238.19047238094, 20257.898710506353, 20261.290854820305, 8157.836843263101, 8339.54132522705, 8384.16158384169, 8412.484389537529, 8568.742937711879, 4826.493218212107, 4827.179379505493, 4838.419389673261, 4858.319835223072, 4911.508849115131, 3279.6556361582166, 3394.372041172391, 3397.11674964511, 3400.472926696366, 3401.608814986308, 611.2878496551557, 613.3222788818381, 618.5144661440747, 624.5440828195352, 633.1990032608753, 624.073251221935, 662.6289278004236, 754.9355408873462, 757.8484303139394, 770.2836362183111, 9179.0, 9215.216706580015, 9473.28950328728, 9480.241580673668, 9563.521823908915, 562.6286650810446, 587.9235699359056, 593.6022864680674, 714.8463080437731, 781.5115552779513, 4238.809253583596, 4493.505714371417, 4743.857684269408, 4918.0901533216465, 5071.4928507149725, 63442.0483692745, 64458.0, 66862.66568667223, 67093.0, 67622.32377676161, 57573.4242657568, 58052.419475805546, 58062.0, 58674.41325586775, 60932.0, 53640.46359536433, 53766.19350709742, 54249.0, 54466.72766636142, 55536.64044469796, 9615.471149086588, 9793.657221997197, 9794.971527989743, 9896.802063958825, 9906.455144966807, 35416.64583354237, 35591.11022224465, 35683.46474802828, 35928.101797455274, 36217.45673814842, 46435.30347044865, 47027.76486117548, 47652.0, 47701.0, 47737.52262477331, 12193.26840389544, 12315.75368492643, 12599.685007874876, 12733.490660373482, 12845.972322214388, 13696.726065478833, 13759.17444953306, 13886.72226555443, 14347.784783228468, 14511.927440362731, 12130.150889437655, 12672.87327126717, 13026.413811378321, 13031.869681303066, 13046.0, 12800.871991279968, 13107.606771796862, 13127.212367257995, 13419.463221471422, 13538.0, 12727.172733772646, 12782.169159004636, 12840.101192916407, 12865.485380584672, 12940.741185176432, 10457.320274182153, 10832.350058996486, 11069.501872415922, 11070.944645276722, 11141.55159829217, 11213.66359009231, 11271.774564508827, 11303.1522635801, 11350.318980861175, 11386.487608057823], "value": 6792.581148976087, "unit": "score"}], "name": "dromaeo_css", "value": 7049.213859360613, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 113.0, 111.0, 113.0, 124.0, 112.0, 114.0, 112.0, 111.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 131.0, 155.0, 186.0, 127.0, 158.0, 163.0, 130.0, 179.0, 132.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 163.0, 164.0, 168.0, 178.0, 164.0, 167.0, 163.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 75.0, 157.0, 76.0, 74.0, 76.0, 77.0, 167.0, 73.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 148.0, 93.0, 92.0, 92.0, 151.0, 94.0, 91.0, 144.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 57.0, 59.0, 59.0, 58.0, 77.0, 57.0, 56.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 60.0, 61.0, 62.0, 60.0, 60.0, 61.0, 62.0, 60.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 83.0, 86.0, 78.0, 84.0, 77.0, 78.0, 78.0, 77.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 125.0, 137.0, 128.0, 124.0, 132.0, 127.0, 130.0, 213.0, 126.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 173.0, 192.0, 170.0, 167.0, 170.0, 171.0, 166.0, 166.0, 171.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 70.0, 69.0, 70.0, 68.0, 67.0, 66.0, 70.0, 68.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1570.9, "alertThreshold": 2.0}]} 23:51:10 INFO - Return code: 0 23:51:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:51:11 ERROR - # TBPL SUCCESS # 23:51:11 INFO - Running post-action listener: _resource_record_post_action 23:51:11 INFO - Running post-run listener: _resource_record_post_run 23:51:12 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536629248; Read time: 8; Write time: 438760 23:51:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 244645888; Read time: 0; Write time: 234724 23:51:12 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291983360; Read time: 8; Write time: 204036 23:51:12 INFO - Running post-run listener: _upload_blobber_files 23:51:12 INFO - Blob upload gear active. 23:51:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:51:12 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 23:51:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:51:12 INFO - (blobuploader) - INFO - Open directory for files ... 23:51:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:51:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:51:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:51:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:51:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:51:13 INFO - (blobuploader) - INFO - Done attempting. 23:51:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:51:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:51:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:51:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:51:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:51:14 INFO - (blobuploader) - INFO - Done attempting. 23:51:14 INFO - (blobuploader) - INFO - Iteration through files over. 23:51:14 INFO - Return code: 0 23:51:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:51:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:51:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2ab54bd76d795a408795ff83fd8be40dc328e8c1db6ce363f0494274489d8c19f9ea2abc4114e9c126f7c1e69d858450eb70dcddf7640b5624a0a3213f98e73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddf885b76c0b24db385739d5a6a11066a38f4f8fb2e090b9694d9f759101e9df72922395414cfd870c8fcc2f0b025543768e45fda617d1bb73d28a8cfc900d5f"} 23:51:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:51:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:51:14 INFO - Contents: 23:51:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2ab54bd76d795a408795ff83fd8be40dc328e8c1db6ce363f0494274489d8c19f9ea2abc4114e9c126f7c1e69d858450eb70dcddf7640b5624a0a3213f98e73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddf885b76c0b24db385739d5a6a11066a38f4f8fb2e090b9694d9f759101e9df72922395414cfd870c8fcc2f0b025543768e45fda617d1bb73d28a8cfc900d5f"} 23:51:14 INFO - Running post-run listener: copy_logs_to_upload_dir 23:51:14 INFO - Copying logs to upload dir... 23:51:14 INFO - mkdir: /builds/slave/test/build/upload/logs 23:51:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.853791 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-28 23:51:13.778450) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 23:51:13.782540) ========= 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=a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2ab54bd76d795a408795ff83fd8be40dc328e8c1db6ce363f0494274489d8c19f9ea2abc4114e9c126f7c1e69d858450eb70dcddf7640b5624a0a3213f98e73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddf885b76c0b24db385739d5a6a11066a38f4f8fb2e090b9694d9f759101e9df72922395414cfd870c8fcc2f0b025543768e45fda617d1bb73d28a8cfc900d5f"} build_url:https://queue.taskcluster.net/v1/task/QsVWERSuSYernE-DSuCtwA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/QsVWERSuSYernE-DSuCtwA/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/sha512/e2ab54bd76d795a408795ff83fd8be40dc328e8c1db6ce363f0494274489d8c19f9ea2abc4114e9c126f7c1e69d858450eb70dcddf7640b5624a0a3213f98e73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddf885b76c0b24db385739d5a6a11066a38f4f8fb2e090b9694d9f759101e9df72922395414cfd870c8fcc2f0b025543768e45fda617d1bb73d28a8cfc900d5f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 23:51:13.807700) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 23:51:13.808086) ========= 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=a0d2d2de893abaa8702a9954000001a7-1461910166.612711-69290005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 23:51:13.894117) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 23:51:13.894454) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 23:51:13.894763) ========= ========= Total master_lag: 0.17 =========