builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1462881477.6 results: success (0) buildid: 20160510031712 builduid: 86163a5b79e0486c9de34d5d04f80478 revision: 8b4e5ab50377a26e6610f21a0f8233467de19e9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 04:57:57.596300) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 04:57:57.596761) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 04:57:57.597041) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 04:57:57.613486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:57:57.613855) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 04:57:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.5M=0s 2016-05-10 04:57:58 (70.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079094 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:57:57.706163) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:57:57.706476) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014987 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:57:57.755591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:57:57.755949) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8b4e5ab50377a26e6610f21a0f8233467de19e9b --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 8b4e5ab50377a26e6610f21a0f8233467de19e9b --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=74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 04:57:58,766 truncating revision to first 12 chars 2016-05-10 04:57:58,767 Setting DEBUG logging. 2016-05-10 04:57:58,767 attempt 1/10 2016-05-10 04:57:58,767 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8b4e5ab50377?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 04:57:59,155 unpacking tar archive at: fx-team-8b4e5ab50377/testing/mozharness/ program finished with exit code 0 elapsedTime=0.682960 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:57:58.451795) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 04:57:58.452129) ========= script_repo_revision: 8b4e5ab50377a26e6610f21a0f8233467de19e9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 04:57:58.452540) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 04:57:58.452830) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 04:57:58.460270) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-10 04:57:58.460630) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:57:59 INFO - MultiFileLogger online at 20160510 04:57:59 in /builds/slave/test 04:57:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:57:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:57:59 INFO - {'append_to_log': False, 04:57:59 INFO - 'base_work_dir': '/builds/slave/test', 04:57:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:57:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:57:59 INFO - 'branch': 'Fx-Team-Non-PGO', 04:57:59 INFO - 'buildbot_json_path': 'buildprops.json', 04:57:59 INFO - 'config_files': ('talos/linux_config.py',), 04:57:59 INFO - 'default_actions': ('clobber', 04:57:59 INFO - 'read-buildbot-config', 04:57:59 INFO - 'download-and-extract', 04:57:59 INFO - 'populate-webroot', 04:57:59 INFO - 'create-virtualenv', 04:57:59 INFO - 'install', 04:57:59 INFO - 'run-tests'), 04:57:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:57:59 INFO - 'download_minidump_stackwalk': True, 04:57:59 INFO - 'download_symbols': 'ondemand', 04:57:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:57:59 INFO - 'tooltool.py': '/tools/tooltool.py', 04:57:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:57:59 INFO - '/tools/misc-python/virtualenv.py')}, 04:57:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:57:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:57:59 INFO - 'installer_path': 'installer.exe', 04:57:59 INFO - 'log_level': 'info', 04:57:59 INFO - 'log_name': 'talos', 04:57:59 INFO - 'log_to_console': True, 04:57:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:57:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:57:59 INFO - 'opt_config_files': (), 04:57:59 INFO - 'pip_index': False, 04:57:59 INFO - 'sps_profile': False, 04:57:59 INFO - 'sps_profile_interval': 0, 04:57:59 INFO - 'suite': 'dromaeojs', 04:57:59 INFO - 'system_bits': '32', 04:57:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:57:59 INFO - 'title': 'talos-linux64-ix-042', 04:57:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:57:59 INFO - 'use_talos_json': True, 04:57:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:57:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:57:59 INFO - 'work_dir': 'build'} 04:57:59 INFO - ##### 04:57:59 INFO - ##### Running clobber step. 04:57:59 INFO - ##### 04:57:59 INFO - Running pre-action listener: _resource_record_pre_action 04:57:59 INFO - Running main action method: clobber 04:57:59 INFO - rmtree: /builds/slave/test/build 04:57:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:58:00 INFO - Running post-action listener: _resource_record_post_action 04:58:00 INFO - ##### 04:58:00 INFO - ##### Finished clobber step (success) 04:58:00 INFO - ##### 04:58:00 INFO - ##### 04:58:00 INFO - ##### Running read-buildbot-config step. 04:58:00 INFO - ##### 04:58:00 INFO - Running pre-action listener: _resource_record_pre_action 04:58:00 INFO - Running main action method: read_buildbot_config 04:58:00 INFO - Using buildbot properties: 04:58:00 INFO - { 04:58:00 INFO - "project": "", 04:58:00 INFO - "product": "firefox", 04:58:00 INFO - "script_repo_revision": "production", 04:58:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:58:00 INFO - "repository": "", 04:58:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:58:00 INFO - "buildid": "20160510031712", 04:58:00 INFO - "pgo_build": "False", 04:58:00 INFO - "basedir": "/builds/slave/test", 04:58:00 INFO - "buildnumber": 2948, 04:58:00 INFO - "slavename": "talos-linux64-ix-042", 04:58:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:58:00 INFO - "platform": "ubuntu64_hw", 04:58:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:58:00 INFO - "branch": "fx-team", 04:58:00 INFO - "repo_path": "integration/fx-team", 04:58:00 INFO - "revision": "8b4e5ab50377a26e6610f21a0f8233467de19e9b", 04:58:00 INFO - "stage_platform": "linux64", 04:58:00 INFO - "builduid": "86163a5b79e0486c9de34d5d04f80478", 04:58:00 INFO - "slavebuilddir": "test" 04:58:00 INFO - } 04:58:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:58:00 INFO - Running post-action listener: _resource_record_post_action 04:58:00 INFO - ##### 04:58:00 INFO - ##### Finished read-buildbot-config step (success) 04:58:00 INFO - ##### 04:58:00 INFO - ##### 04:58:00 INFO - ##### Running download-and-extract step. 04:58:00 INFO - ##### 04:58:00 INFO - Running pre-action listener: _resource_record_pre_action 04:58:00 INFO - Running main action method: download_and_extract 04:58:00 INFO - mkdir: /builds/slave/test/build/tests 04:58:00 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')]} 04:58:00 INFO - https://queue.taskcluster.net/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:58:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:58:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:58:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/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 04:58:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/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 04:58:01 INFO - Downloaded 1361 bytes. 04:58:01 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:58:01 INFO - Using the following test package requirements: 04:58:01 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:58:01 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:58:01 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:58:01 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:01 INFO - u'jsshell-linux-x86_64.zip'], 04:58:01 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:58:01 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:58:01 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:58:01 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:58:01 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:58:01 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:58:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:58:01 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:01 INFO - https://queue.taskcluster.net/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:58:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:58:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:58:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/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 04:58:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/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 04:58:02 INFO - Downloaded 22325903 bytes. 04:58:02 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'] 04:58:02 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 04:58:03 INFO - Return code: 0 04:58:03 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 04:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:03 INFO - https://queue.taskcluster.net/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:58:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:58:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:58:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/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 04:58:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/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 04:58:05 INFO - Downloaded 22325903 bytes. 04:58:05 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'] 04:58:05 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 04:58:07 INFO - Return code: 0 04:58:07 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')]} 04:58:07 INFO - https://queue.taskcluster.net/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:58:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:58:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:58:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/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 04:58:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/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 04:58:08 INFO - Downloaded 10840152 bytes. 04:58:08 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'] 04:58:08 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 04:58:08 INFO - Return code: 0 04:58: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')]} 04:58:08 INFO - https://queue.taskcluster.net/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:58:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:58:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:58:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/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 04:58:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2CToNDwTTutH_93JVw51g/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 04:58:10 INFO - Downloaded 54672570 bytes. 04:58:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:58:10 INFO - mkdir: /builds/slave/test/properties 04:58:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:58:10 INFO - Writing to file /builds/slave/test/properties/build_url 04:58:10 INFO - Contents: 04:58:10 INFO - build_url:https://queue.taskcluster.net/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:58:10 INFO - Running post-action listener: _resource_record_post_action 04:58:10 INFO - Running post-action listener: set_extra_try_arguments 04:58:10 INFO - ##### 04:58:10 INFO - ##### Finished download-and-extract step (success) 04:58:10 INFO - ##### 04:58:10 INFO - ##### 04:58:10 INFO - ##### Running populate-webroot step. 04:58:10 INFO - ##### 04:58:10 INFO - Running pre-action listener: _resource_record_pre_action 04:58:10 INFO - Running main action method: populate_webroot 04:58:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:58:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:58:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:58:11 INFO - '--tppagecycles', 04:58:11 INFO - '7'], 04:58:11 INFO - 'tests': ['tsvgm']}}, 04:58:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:58:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:58:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:58:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:58:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:58:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:58:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:11 INFO - 'talos_options': ['--disable-e10s'], 04:58:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:58:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:58:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:11 INFO - 'talos_options': ['--disable-e10s'], 04:58:11 INFO - 'tests': ['damp', 'tps']}, 04:58:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:11 INFO - 'tests': ['damp', 'tps']}, 04:58:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:58:11 INFO - 'tests': ['dromaeo_dom']}, 04:58:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:58:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:58:11 INFO - 'tests': ['a11yr', 04:58:11 INFO - 'ts_paint', 04:58:11 INFO - 'tpaint', 04:58:11 INFO - 'sessionrestore', 04:58:11 INFO - 'sessionrestore_no_auto_restore', 04:58:11 INFO - 'tabpaint']}, 04:58:11 INFO - 'other-e10s': {'tests': ['a11yr', 04:58:11 INFO - 'ts_paint', 04:58:11 INFO - 'tpaint', 04:58:11 INFO - 'sessionrestore', 04:58:11 INFO - 'sessionrestore_no_auto_restore', 04:58:11 INFO - 'tabpaint']}, 04:58:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:58:11 INFO - 'ts_paint', 04:58:11 INFO - 'tpaint', 04:58:11 INFO - 'sessionrestore', 04:58:11 INFO - 'sessionrestore_no_auto_restore', 04:58:11 INFO - 'tabpaint']}, 04:58:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:58:11 INFO - 'ts_paint', 04:58:11 INFO - 'tpaint', 04:58:11 INFO - 'sessionrestore', 04:58:11 INFO - 'sessionrestore_no_auto_restore', 04:58:11 INFO - 'tabpaint']}, 04:58:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:58:11 INFO - 'tests': ['a11yr', 04:58:11 INFO - 'ts_paint', 04:58:11 INFO - 'tpaint', 04:58:11 INFO - 'sessionrestore', 04:58:11 INFO - 'sessionrestore_no_auto_restore', 04:58:11 INFO - 'tabpaint']}, 04:58:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:58:11 INFO - 'tests': ['a11yr', 04:58:11 INFO - 'ts_paint', 04:58:11 INFO - 'tpaint', 04:58:11 INFO - 'sessionrestore', 04:58:11 INFO - 'sessionrestore_no_auto_restore', 04:58:11 INFO - 'tabpaint']}, 04:58:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:58:11 INFO - 'tests': ['tsvgx', 04:58:11 INFO - 'tsvgr_opacity', 04:58:11 INFO - 'tart', 04:58:11 INFO - 'tscrollx', 04:58:11 INFO - 'cart']}, 04:58:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:58:11 INFO - 'tsvgr_opacity', 04:58:11 INFO - 'tart', 04:58:11 INFO - 'tscrollx', 04:58:11 INFO - 'cart']}, 04:58:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:11 INFO - 'talos_options': ['--disable-e10s'], 04:58:11 INFO - 'tests': ['tp5o']}, 04:58:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:11 INFO - 'tests': ['tp5o']}, 04:58:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:11 INFO - 'talos_options': ['--disable-e10s', 04:58:11 INFO - '--xperf_path', 04:58:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:58:11 INFO - 'tests': ['tp5n']}, 04:58:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:11 INFO - 'talos_options': ['--xperf_path', 04:58:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:58:11 INFO - 'tests': ['tp5n']}}, 04:58:11 INFO - 'talos.zip': {'path': '', 04:58:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:58:11 INFO - Running post-action listener: _resource_record_post_action 04:58:11 INFO - ##### 04:58:11 INFO - ##### Finished populate-webroot step (success) 04:58:11 INFO - ##### 04:58:11 INFO - ##### 04:58:11 INFO - ##### Running create-virtualenv step. 04:58:11 INFO - ##### 04:58:11 INFO - Running pre-action listener: _resource_record_pre_action 04:58:11 INFO - Running main action method: create_virtualenv 04:58:11 INFO - Creating virtualenv /builds/slave/test/build/venv 04:58:11 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 04:58:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:58:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:58:11 INFO - Using real prefix '/usr' 04:58:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:58:11 INFO - Installing distribute.............................................................................................................................................................................................done. 04:58:13 INFO - Installing pip.................done. 04:58:13 INFO - Return code: 0 04:58:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:13 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 0x7fe1020a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9c0>, '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 0xfbc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbcd50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', '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 04:58:13 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 04:58:13 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 04:58:13 INFO - Using env: {'DISPLAY': ':0', 04:58:13 INFO - 'HOME': '/home/cltbld', 04:58:13 INFO - 'LANG': 'en_US.UTF-8', 04:58:13 INFO - 'LANGUAGE': 'en_US:en', 04:58:13 INFO - 'LOGNAME': 'cltbld', 04:58:13 INFO - 'MAIL': '/var/mail/cltbld', 04:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:13 INFO - 'MOZ_NO_REMOTE': '1', 04:58:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:13 INFO - 'NO_EM_RESTART': '1', 04:58:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:13 INFO - 'PWD': '/builds/slave/test', 04:58:13 INFO - 'SHELL': '/bin/bash', 04:58:13 INFO - 'SHLVL': '1', 04:58:13 INFO - 'TERM': 'linux', 04:58:13 INFO - 'TMOUT': '86400', 04:58:13 INFO - 'USER': 'cltbld', 04:58:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', 04:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:13 INFO - '_': '/tools/buildbot/bin/python'} 04:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:13 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 04:58:13 INFO - Cleaning up... 04:58:13 INFO - Return code: 0 04:58:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:13 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 0x7fe1020a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9c0>, '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 0xfbc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbcd50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', '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 04:58:13 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 04:58:13 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 04:58:13 INFO - Using env: {'DISPLAY': ':0', 04:58:13 INFO - 'HOME': '/home/cltbld', 04:58:13 INFO - 'LANG': 'en_US.UTF-8', 04:58:13 INFO - 'LANGUAGE': 'en_US:en', 04:58:13 INFO - 'LOGNAME': 'cltbld', 04:58:13 INFO - 'MAIL': '/var/mail/cltbld', 04:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:13 INFO - 'MOZ_NO_REMOTE': '1', 04:58:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:13 INFO - 'NO_EM_RESTART': '1', 04:58:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:13 INFO - 'PWD': '/builds/slave/test', 04:58:13 INFO - 'SHELL': '/bin/bash', 04:58:13 INFO - 'SHLVL': '1', 04:58:13 INFO - 'TERM': 'linux', 04:58:13 INFO - 'TMOUT': '86400', 04:58:13 INFO - 'USER': 'cltbld', 04:58:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', 04:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:13 INFO - '_': '/tools/buildbot/bin/python'} 04:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:13 INFO - Downloading/unpacking psutil>=0.7.1 04:58:13 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 04:58:13 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 04:58:13 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 04:58:13 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 04:58:13 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 04:58:13 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 04:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:58:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:58:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:16 INFO - Installing collected packages: psutil 04:58:16 INFO - Running setup.py install for psutil 04:58:16 INFO - building 'psutil._psutil_linux' extension 04:58:16 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 04:58:16 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 04:58:16 INFO - building 'psutil._psutil_posix' extension 04:58:16 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 04:58:16 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 04:58:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:58:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:16 INFO - Successfully installed psutil 04:58:16 INFO - Cleaning up... 04:58:16 INFO - Return code: 0 04:58:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:16 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 0x7fe1020a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9c0>, '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 0xfbc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbcd50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', '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 04:58:16 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 04:58:16 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 04:58:16 INFO - Using env: {'DISPLAY': ':0', 04:58:16 INFO - 'HOME': '/home/cltbld', 04:58:16 INFO - 'LANG': 'en_US.UTF-8', 04:58:16 INFO - 'LANGUAGE': 'en_US:en', 04:58:16 INFO - 'LOGNAME': 'cltbld', 04:58:16 INFO - 'MAIL': '/var/mail/cltbld', 04:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:16 INFO - 'MOZ_NO_REMOTE': '1', 04:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:16 INFO - 'NO_EM_RESTART': '1', 04:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:16 INFO - 'PWD': '/builds/slave/test', 04:58:16 INFO - 'SHELL': '/bin/bash', 04:58:16 INFO - 'SHLVL': '1', 04:58:16 INFO - 'TERM': 'linux', 04:58:16 INFO - 'TMOUT': '86400', 04:58:16 INFO - 'USER': 'cltbld', 04:58:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', 04:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:16 INFO - '_': '/tools/buildbot/bin/python'} 04:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:58:16 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 04:58:16 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 04:58:16 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 04:58:16 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 04:58:16 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 04:58:16 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 04:58:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:58:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:58:18 INFO - Installing collected packages: mozsystemmonitor 04:58:18 INFO - Running setup.py install for mozsystemmonitor 04:58:18 INFO - Successfully installed mozsystemmonitor 04:58:18 INFO - Cleaning up... 04:58:18 INFO - Return code: 0 04:58:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:18 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 0x7fe1020a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9c0>, '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 0xfbc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbcd50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', '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 04:58:18 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 04:58:18 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 04:58:18 INFO - Using env: {'DISPLAY': ':0', 04:58:18 INFO - 'HOME': '/home/cltbld', 04:58:18 INFO - 'LANG': 'en_US.UTF-8', 04:58:18 INFO - 'LANGUAGE': 'en_US:en', 04:58:18 INFO - 'LOGNAME': 'cltbld', 04:58:18 INFO - 'MAIL': '/var/mail/cltbld', 04:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:18 INFO - 'MOZ_NO_REMOTE': '1', 04:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:18 INFO - 'NO_EM_RESTART': '1', 04:58:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:18 INFO - 'PWD': '/builds/slave/test', 04:58:18 INFO - 'SHELL': '/bin/bash', 04:58:18 INFO - 'SHLVL': '1', 04:58:18 INFO - 'TERM': 'linux', 04:58:18 INFO - 'TMOUT': '86400', 04:58:18 INFO - 'USER': 'cltbld', 04:58:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', 04:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:18 INFO - '_': '/tools/buildbot/bin/python'} 04:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:19 INFO - Downloading/unpacking blobuploader==1.2.4 04:58:19 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 04:58:19 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 04:58:19 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 04:58:19 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 04:58:19 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 04:58:19 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 04:58:20 INFO - Downloading blobuploader-1.2.4.tar.gz 04:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:58:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:58:21 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 04:58:21 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 04:58:21 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 04:58:21 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 04:58:21 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 04:58:21 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 04:58:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:58:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:58:21 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 04:58:21 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 04:58:21 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 04:58:21 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 04:58:21 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 04:58:21 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 04:58:21 INFO - Downloading docopt-0.6.1.tar.gz 04:58:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:58:21 INFO - Installing collected packages: blobuploader, requests, docopt 04:58:21 INFO - Running setup.py install for blobuploader 04:58:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:58:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:58:21 INFO - Running setup.py install for requests 04:58:22 INFO - Running setup.py install for docopt 04:58:22 INFO - Successfully installed blobuploader requests docopt 04:58:22 INFO - Cleaning up... 04:58:22 INFO - Return code: 0 04:58:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:22 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')]} 04:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:22 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')]} 04:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:22 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 0x7fe1020a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9c0>, '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 0xfbc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbcd50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', '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 04:58:22 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 04:58:22 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 04:58:22 INFO - Using env: {'DISPLAY': ':0', 04:58:22 INFO - 'HOME': '/home/cltbld', 04:58:22 INFO - 'LANG': 'en_US.UTF-8', 04:58:22 INFO - 'LANGUAGE': 'en_US:en', 04:58:22 INFO - 'LOGNAME': 'cltbld', 04:58:22 INFO - 'MAIL': '/var/mail/cltbld', 04:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:22 INFO - 'MOZ_NO_REMOTE': '1', 04:58:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:22 INFO - 'NO_EM_RESTART': '1', 04:58:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:22 INFO - 'PWD': '/builds/slave/test', 04:58:22 INFO - 'SHELL': '/bin/bash', 04:58:22 INFO - 'SHLVL': '1', 04:58:22 INFO - 'TERM': 'linux', 04:58:22 INFO - 'TMOUT': '86400', 04:58:22 INFO - 'USER': 'cltbld', 04:58:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', 04:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:22 INFO - '_': '/tools/buildbot/bin/python'} 04:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:58:22 INFO - Running setup.py (path:/tmp/pip-GeUJu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:58:22 INFO - Running setup.py (path:/tmp/pip-6CYg15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:58:22 INFO - Running setup.py (path:/tmp/pip-vDKiPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:58:22 INFO - Running setup.py (path:/tmp/pip-HBvGhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:58:22 INFO - Running setup.py (path:/tmp/pip-v7kkyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:58:22 INFO - Running setup.py (path:/tmp/pip-VR0czw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:58:22 INFO - Running setup.py (path:/tmp/pip-GVc_jB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:58:23 INFO - Running setup.py (path:/tmp/pip-pt7hzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:58:23 INFO - Running setup.py (path:/tmp/pip-5Rn1YP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:58:23 INFO - Running setup.py (path:/tmp/pip-_X0bbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:58:23 INFO - Running setup.py (path:/tmp/pip-8GOsWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:58:23 INFO - Running setup.py (path:/tmp/pip-untl5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:58:23 INFO - Running setup.py (path:/tmp/pip-ZQToXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:58:23 INFO - Running setup.py (path:/tmp/pip-t5q9wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:23 INFO - Running setup.py (path:/tmp/pip-koqDEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:58:23 INFO - Running setup.py (path:/tmp/pip-b_bmaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:58:23 INFO - Running setup.py (path:/tmp/pip-X0sn8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:58:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:58:23 INFO - Running setup.py install for manifestparser 04:58:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:58:23 INFO - Running setup.py install for mozcrash 04:58:23 INFO - Running setup.py install for mozdebug 04:58:24 INFO - Running setup.py install for mozdevice 04:58:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:58:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:58:24 INFO - Running setup.py install for mozfile 04:58:24 INFO - Running setup.py install for mozhttpd 04:58:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:58:24 INFO - Running setup.py install for mozinfo 04:58:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:58:24 INFO - Running setup.py install for mozInstall 04:58:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:58:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:58:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:58:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:58:24 INFO - Running setup.py install for mozleak 04:58:24 INFO - Running setup.py install for mozlog 04:58:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:58:24 INFO - Running setup.py install for moznetwork 04:58:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:58:24 INFO - Running setup.py install for mozprocess 04:58:24 INFO - Running setup.py install for mozprofile 04:58:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:58:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:58:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:58:25 INFO - Running setup.py install for mozrunner 04:58:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:58:25 INFO - Running setup.py install for mozscreenshot 04:58:25 INFO - Running setup.py install for moztest 04:58:25 INFO - Running setup.py install for mozversion 04:58:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:58:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:58:25 INFO - Cleaning up... 04:58:25 INFO - Return code: 0 04:58:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:25 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 0x7fe1020a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9c0>, '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 0xfbc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbcd50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', '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 04:58:25 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 04:58:25 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 04:58:25 INFO - Using env: {'DISPLAY': ':0', 04:58:25 INFO - 'HOME': '/home/cltbld', 04:58:25 INFO - 'LANG': 'en_US.UTF-8', 04:58:25 INFO - 'LANGUAGE': 'en_US:en', 04:58:25 INFO - 'LOGNAME': 'cltbld', 04:58:25 INFO - 'MAIL': '/var/mail/cltbld', 04:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:25 INFO - 'MOZ_NO_REMOTE': '1', 04:58:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:25 INFO - 'NO_EM_RESTART': '1', 04:58:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:25 INFO - 'PWD': '/builds/slave/test', 04:58:25 INFO - 'SHELL': '/bin/bash', 04:58:25 INFO - 'SHLVL': '1', 04:58:25 INFO - 'TERM': 'linux', 04:58:25 INFO - 'TMOUT': '86400', 04:58:25 INFO - 'USER': 'cltbld', 04:58:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', 04:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:25 INFO - '_': '/tools/buildbot/bin/python'} 04:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:58:25 INFO - Running setup.py (path:/tmp/pip-1wkhKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:58:25 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)) 04:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:58:25 INFO - Running setup.py (path:/tmp/pip-Ugu5ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:58:25 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)) 04:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:58:25 INFO - Running setup.py (path:/tmp/pip-V2_0AP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:58:25 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)) 04:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:58:25 INFO - Running setup.py (path:/tmp/pip-C5T8sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:58:26 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)) 04:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:58:26 INFO - Running setup.py (path:/tmp/pip-sYlbGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:58:26 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)) 04:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:58:26 INFO - Running setup.py (path:/tmp/pip-FCOqQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:58:26 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)) 04:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:58:26 INFO - Running setup.py (path:/tmp/pip-r2kFOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:58:26 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)) 04:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:58:26 INFO - Running setup.py (path:/tmp/pip-FSRCKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:58:26 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)) 04:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:58:26 INFO - Running setup.py (path:/tmp/pip-IOPkB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:58:26 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)) 04:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:58:26 INFO - Running setup.py (path:/tmp/pip-EI3m_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:58:26 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)) 04:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:58:26 INFO - Running setup.py (path:/tmp/pip-OazJde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:58:26 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)) 04:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:58:26 INFO - Running setup.py (path:/tmp/pip-osbX8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:58:26 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)) 04:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:58:26 INFO - Running setup.py (path:/tmp/pip-fKNWsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:58:26 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)) 04:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:58:26 INFO - Running setup.py (path:/tmp/pip-gDRPZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:58:26 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)) 04:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:26 INFO - Running setup.py (path:/tmp/pip-CthSXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:26 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)) 04:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:58:26 INFO - Running setup.py (path:/tmp/pip-ZTHBsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:58:26 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)) 04:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:58:26 INFO - Running setup.py (path:/tmp/pip-uE8qgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:58:26 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)) 04:58:26 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)) 04:58:26 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)) 04:58:26 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)) 04:58:26 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)) 04:58:26 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)) 04:58:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:58:26 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 04:58:26 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 04:58:26 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 04:58:26 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 04:58:26 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 04:58:26 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 04:58:28 INFO - Downloading blessings-1.6.tar.gz 04:58:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:58:28 INFO - Installing collected packages: blessings 04:58:28 INFO - Running setup.py install for blessings 04:58:29 INFO - Successfully installed blessings 04:58:29 INFO - Cleaning up... 04:58:29 INFO - Return code: 0 04:58:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:58:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:58:29 INFO - Reading from file tmpfile_stdout 04:58:29 INFO - Current package versions: 04:58:29 INFO - argparse == 1.2.1 04:58:29 INFO - blessings == 1.6 04:58:29 INFO - blobuploader == 1.2.4 04:58:29 INFO - docopt == 0.6.1 04:58:29 INFO - manifestparser == 1.1 04:58:29 INFO - mozInstall == 1.12 04:58:29 INFO - mozcrash == 0.17 04:58:29 INFO - mozdebug == 0.1 04:58:29 INFO - mozdevice == 0.48 04:58:29 INFO - mozfile == 1.2 04:58:29 INFO - mozhttpd == 0.7 04:58:29 INFO - mozinfo == 0.9 04:58:29 INFO - mozleak == 0.1 04:58:29 INFO - mozlog == 3.1 04:58:29 INFO - moznetwork == 0.27 04:58:29 INFO - mozprocess == 0.22 04:58:29 INFO - mozprofile == 0.28 04:58:29 INFO - mozrunner == 6.11 04:58:29 INFO - mozscreenshot == 0.1 04:58:29 INFO - mozsystemmonitor == 0.0 04:58:29 INFO - moztest == 0.7 04:58:29 INFO - mozversion == 1.4 04:58:29 INFO - psutil == 3.1.1 04:58:29 INFO - requests == 1.2.3 04:58:29 INFO - wsgiref == 0.1.2 04:58:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:29 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 0x7fe1020a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9c0>, '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 0xfbc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbcd50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', '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 04:58:29 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 04:58:29 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 04:58:29 INFO - Using env: {'DISPLAY': ':0', 04:58:29 INFO - 'HOME': '/home/cltbld', 04:58:29 INFO - 'LANG': 'en_US.UTF-8', 04:58:29 INFO - 'LANGUAGE': 'en_US:en', 04:58:29 INFO - 'LOGNAME': 'cltbld', 04:58:29 INFO - 'MAIL': '/var/mail/cltbld', 04:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:29 INFO - 'MOZ_NO_REMOTE': '1', 04:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:29 INFO - 'NO_EM_RESTART': '1', 04:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:29 INFO - 'PWD': '/builds/slave/test', 04:58:29 INFO - 'SHELL': '/bin/bash', 04:58:29 INFO - 'SHLVL': '1', 04:58:29 INFO - 'TERM': 'linux', 04:58:29 INFO - 'TMOUT': '86400', 04:58:29 INFO - 'USER': 'cltbld', 04:58:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', 04:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:29 INFO - '_': '/tools/buildbot/bin/python'} 04:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:29 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)) 04:58:29 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)) 04:58:29 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)) 04:58:29 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)) 04:58:29 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)) 04:58:29 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)) 04:58:29 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)) 04:58:29 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)) 04:58:29 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)) 04:58:29 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)) 04:58:29 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)) 04:58:29 INFO - Cleaning up... 04:58:29 INFO - Return code: 0 04:58:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1020a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9c0>, '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 0xfbc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbcd50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', '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 04:58:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:58:29 INFO - Using env: {'DISPLAY': ':0', 04:58:29 INFO - 'HOME': '/home/cltbld', 04:58:29 INFO - 'LANG': 'en_US.UTF-8', 04:58:29 INFO - 'LANGUAGE': 'en_US:en', 04:58:29 INFO - 'LOGNAME': 'cltbld', 04:58:29 INFO - 'MAIL': '/var/mail/cltbld', 04:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:29 INFO - 'MOZ_NO_REMOTE': '1', 04:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:29 INFO - 'NO_EM_RESTART': '1', 04:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:29 INFO - 'PWD': '/builds/slave/test', 04:58:29 INFO - 'SHELL': '/bin/bash', 04:58:29 INFO - 'SHLVL': '1', 04:58:29 INFO - 'TERM': 'linux', 04:58:29 INFO - 'TMOUT': '86400', 04:58:29 INFO - 'USER': 'cltbld', 04:58:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', 04:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:29 INFO - '_': '/tools/buildbot/bin/python'} 04:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:29 INFO - Downloading/unpacking jsonschema 04:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:58:31 INFO - Downloading/unpacking functools32 (from jsonschema) 04:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:31 INFO - Downloading functools32-3.2.3-2.tar.gz 04:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:58:31 INFO - warning: no files found matching '*.txt' 04:58:31 INFO - no previously-included directories found matching 'build' 04:58:31 INFO - no previously-included directories found matching 'dist' 04:58:31 INFO - no previously-included directories found matching '.git*' 04:58:31 INFO - Installing collected packages: jsonschema, functools32 04:58:31 INFO - Running setup.py install for functools32 04:58:32 INFO - warning: no files found matching '*.txt' 04:58:32 INFO - no previously-included directories found matching 'build' 04:58:32 INFO - no previously-included directories found matching 'dist' 04:58:32 INFO - no previously-included directories found matching '.git*' 04:58:32 INFO - Successfully installed jsonschema functools32 04:58:32 INFO - Cleaning up... 04:58:32 INFO - Return code: 0 04:58:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:32 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 0x7fe1020a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb9c0>, '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 0xfbc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbcd50>, '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': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', '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 04:58:32 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 04:58:32 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 04:58:32 INFO - Using env: {'DISPLAY': ':0', 04:58:32 INFO - 'HOME': '/home/cltbld', 04:58:32 INFO - 'LANG': 'en_US.UTF-8', 04:58:32 INFO - 'LANGUAGE': 'en_US:en', 04:58:32 INFO - 'LOGNAME': 'cltbld', 04:58:32 INFO - 'MAIL': '/var/mail/cltbld', 04:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:32 INFO - 'MOZ_NO_REMOTE': '1', 04:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:32 INFO - 'NO_EM_RESTART': '1', 04:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:32 INFO - 'PWD': '/builds/slave/test', 04:58:32 INFO - 'SHELL': '/bin/bash', 04:58:32 INFO - 'SHLVL': '1', 04:58:32 INFO - 'TERM': 'linux', 04:58:32 INFO - 'TMOUT': '86400', 04:58:32 INFO - 'USER': 'cltbld', 04:58:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', 04:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:32 INFO - '_': '/tools/buildbot/bin/python'} 04:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:32 INFO - Downloading/unpacking flake8 04:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:58:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:58:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:58:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:58:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:58:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:58:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:58:34 INFO - no previously-included directories found matching 'docs/_build' 04:58:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:58:34 INFO - Running setup.py install for pep8 04:58:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:58:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:58:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:58:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:58:35 INFO - no previously-included directories found matching 'docs/_build' 04:58:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:58:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:58:35 INFO - Cleaning up... 04:58:35 INFO - Return code: 0 04:58:35 INFO - Running post-action listener: _resource_record_post_action 04:58:35 INFO - Running post-action listener: _start_resource_monitoring 04:58:35 INFO - Starting resource monitoring. 04:58:35 INFO - ##### 04:58:35 INFO - ##### Finished create-virtualenv step (success) 04:58:35 INFO - ##### 04:58:35 INFO - ##### 04:58:35 INFO - ##### Running install step. 04:58:35 INFO - ##### 04:58:35 INFO - Running pre-action listener: _resource_record_pre_action 04:58:35 INFO - Running main action method: install 04:58:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:58:35 INFO - Reading from file tmpfile_stdout 04:58:35 INFO - Detecting whether we're running mozinstall >=1.0... 04:58:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:58:35 INFO - Reading from file tmpfile_stdout 04:58:35 INFO - Output received: 04:58:35 INFO - Usage: mozinstall [options] installer 04:58:35 INFO - Options: 04:58:35 INFO - -h, --help show this help message and exit 04:58:35 INFO - -d DEST, --destination=DEST 04:58:35 INFO - Directory to install application into. [default: 04:58:35 INFO - "/builds/slave/test"] 04:58:35 INFO - --app=APP Application being installed. [default: firefox] 04:58:35 INFO - mkdir: /builds/slave/test/build/application 04:58:35 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'] 04:58:35 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 04:58:51 INFO - Reading from file tmpfile_stdout 04:58:51 INFO - Output received: 04:58:51 INFO - /builds/slave/test/build/application/firefox/firefox 04:58:51 INFO - Running post-action listener: _resource_record_post_action 04:58:51 INFO - ##### 04:58:51 INFO - ##### Finished install step (success) 04:58:51 INFO - ##### 04:58:51 INFO - ##### 04:58:51 INFO - ##### Running run-tests step. 04:58:51 INFO - ##### 04:58:51 INFO - Running pre-action listener: _resource_record_pre_action 04:58:51 INFO - Running main action method: run_tests 04:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:58:51 INFO - Python 2.7.3 04:58:51 INFO - Return code: 0 04:58:51 INFO - grabbing minidump binary from tooltool 04:58:51 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')]} 04:58:51 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 0xfbb9c0>, '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 0xfbc8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbcd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:58:51 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 04:58:51 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 04:58:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:58:51 INFO - Return code: 0 04:58:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:58:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:58:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:58:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:58:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:58:52 INFO - Return code: 0 04:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:58:52 INFO - Using env: {'DISPLAY': ':0', 04:58:52 INFO - 'HOME': '/home/cltbld', 04:58:52 INFO - 'LANG': 'en_US.UTF-8', 04:58:52 INFO - 'LANGUAGE': 'en_US:en', 04:58:52 INFO - 'LOGNAME': 'cltbld', 04:58:52 INFO - 'MAIL': '/var/mail/cltbld', 04:58:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:58:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:52 INFO - 'MOZ_NO_REMOTE': '1', 04:58:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:52 INFO - 'NO_EM_RESTART': '1', 04:58:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:52 INFO - 'PWD': '/builds/slave/test', 04:58:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:58:52 INFO - 'SHELL': '/bin/bash', 04:58:52 INFO - 'SHLVL': '1', 04:58:52 INFO - 'TERM': 'linux', 04:58:52 INFO - 'TMOUT': '86400', 04:58:52 INFO - 'USER': 'cltbld', 04:58:52 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471', 04:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:52 INFO - '_': '/tools/buildbot/bin/python'} 04:58:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:58:52 INFO - mozversion application_buildid: 20160510031712 04:58:52 INFO - mozversion application_changeset: 8b4e5ab50377a26e6610f21a0f8233467de19e9b 04:58:52 INFO - mozversion application_display_name: Nightly 04:58:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:58:52 INFO - mozversion application_name: Firefox 04:58:52 INFO - mozversion application_remotingname: firefox 04:58:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:58:52 INFO - mozversion application_vendor: Mozilla 04:58:52 INFO - mozversion application_version: 49.0a1 04:58:52 INFO - mozversion platform_buildid: 20160510031712 04:58:52 INFO - mozversion platform_changeset: 8b4e5ab50377a26e6610f21a0f8233467de19e9b 04:58:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:58:52 INFO - mozversion platform_version: 49.0a1 04:58:52 INFO - using testdate: 1462881532 04:58:52 INFO - actual date: 1462881532 04:58:52 INFO - starting webserver on 'localhost:48774' 04:58:52 INFO - SUITE-START | Running 2 tests 04:58:52 INFO - TEST-START | dromaeo_css 04:58:52 INFO - operating with platform_type : linux_ 04:58:52 INFO - Initialising browser for dromaeo_css test... 04:58:52 INFO - TEST-INFO | started process 18366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpboCgPc/profile http://localhost:48774/getInfo.html) 04:58:57 INFO - PROCESS | 18366 | __metrics Screen width/height:1600/1200 04:58:57 INFO - PROCESS | 18366 | colorDepth:24 04:58:57 INFO - PROCESS | 18366 | Browser inner width/height: 1024/697 04:58:57 INFO - PROCESS | 18366 | __metrics 04:58:58 ERROR - PROCESS | 18366 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:58:59 INFO - TEST-INFO | 18366: exit 0 04:58:59 INFO - Browser initialized. 04:58:59 INFO - Running cycle 1/1 for dromaeo_css test... 04:58:59 INFO - TEST-INFO | started process 18447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpboCgPc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:59:11 INFO - PROCESS | 18447 | RSS: Main: 154337280 04:59:11 INFO - PROCESS | 18447 | 05:00:02 INFO - PROCESS | 18447 | 1462881602777 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] 05:02:14 INFO - PROCESS | 18447 | Cycle 1(1): loaded http://localhost:48774/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48774/tests/dromaeo/cssquery-ext.html) 05:02:15 INFO - PROCESS | 18447 | RSS: Main: 232824832 05:02:15 INFO - PROCESS | 18447 | 05:05:18 INFO - PROCESS | 18447 | Cycle 1(1): loaded http://localhost:48774/tests/dromaeo/cssquery-ext.html (next: http://localhost:48774/tests/dromaeo/cssquery-jquery.html) 05:05:18 INFO - PROCESS | 18447 | RSS: Main: 232148992 05:05:18 INFO - PROCESS | 18447 | 05:08:20 INFO - PROCESS | 18447 | Cycle 1(1): loaded http://localhost:48774/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48774/tests/dromaeo/cssquery-mootools.html) 05:08:21 INFO - PROCESS | 18447 | RSS: Main: 234074112 05:08:21 INFO - PROCESS | 18447 | 05:11:23 INFO - PROCESS | 18447 | Cycle 1(1): loaded http://localhost:48774/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48774/tests/dromaeo/cssquery-prototype.html) 05:11:24 INFO - PROCESS | 18447 | RSS: Main: 235618304 05:11:24 INFO - PROCESS | 18447 | 05:14:27 INFO - PROCESS | 18447 | Cycle 1(1): loaded http://localhost:48774/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48774/tests/dromaeo/cssquery-yui.html) 05:14:27 INFO - PROCESS | 18447 | RSS: Main: 209612800 05:14:27 INFO - PROCESS | 18447 | 05:17:30 INFO - PROCESS | 18447 | Cycle 1(1): loaded http://localhost:48774/tests/dromaeo/cssquery-yui.html (next: http://localhost:48774/tests/dromaeo/cssquery-dojo.html) 05:17:30 INFO - PROCESS | 18447 | RSS: Main: 269713408 05:17:30 INFO - PROCESS | 18447 | 05:17:30 INFO - PROCESS | 18447 | __start_tp_report 05:17:30 INFO - PROCESS | 18447 | _x_x_mozilla_page_load 05:17:30 INFO - PROCESS | 18447 | _x_x_mozilla_page_load_details 05:17:30 INFO - PROCESS | 18447 | |i|pagename|runs| 05:17:30 INFO - PROCESS | 18447 | |0;dojo.html;2644.9338766530836;2651.0323731837884;2695.5417579011564;2706.6751989761233;2712.7287271272876;4617.353570500132;4677.2750223715375;4710.246360582308;4770.451398089221;4808.254720518321;4751.3348131261655;4756.405449318835;4766.046790641877;4801.495842936493;4805.61555075594;4333.11171209902;4367.825286988516;4409.757463339515;4434.35701823237;4513.864584062483;4425.22558552252;4463.73217606943;4475.485319188286;4478.97760511197;4499.437570303712;4279.871603851859;4299.140171965588;4346.282863327548;4350.934735978963;4366.170427618742;4286.57134286572;4398.824047038114;4400.471943366784;4409.49290831552;4454.5990860822685;4384.101259241847;4398.912021759547;4399.252127138362;4426.026274219666;4440.555944405566;4479.104179164147;4557.772111394417;4596.954030459719;4605.470370907355;4661.324108004321;5007.37407824022;5029.949700502984;5074.746262686888;5076.695398276115;5079.8984020319385;4876;5077.111505486525;5107.846764597031;5113.463086375914;5127.435982041972;4686.695364801277;4738.952610473852;4739.95260047402;4739.976300118477;4742.4309082909585;5112.514311140436;5187.0922588546855;5188.429272779991;5192.948070519322;5210.400803907523;4906.215005599087;4931.457539670633;4957.950420495821;4990.10178167926;5001.89996200074;5034.270030845507;5040.470750571138;5057.544820966131;5111.5655169310285;5119.539241468211;5007.7245751484015;5014.874628134253;5020.47285035066;5022.497750225021;5067.265246539231;4848.8302909398;5000.89998200034;5025.698458092526;5031.823886163967;5033.471485494044;4383.912321753547;4404.2512772828695;4410.823567057346;4434.467863856358;4453.732776033448;3791.734578579473;3798.848046078181;3804.9809750951067;3822.57951625321;3840.30874442603;4235;4287.3140297552245;4386.407834942306;4392.38506609075;4425.491068527096;4983.626228032839;5039.521245481674;5043.092243396224;5050.4697006814495;5063.139266324733;4329.545397733193;4331.848385306499;4331.935020974688;4341.834594875285;4374.300111982067;4492;4580.335851301543;4585.862424127282;4627.838025669085;4646.094011667692;4798.640101992295;4810.39870016248;4814.325994360863;4828.37231159947;4863;5142.5885929126325;5144.356955380577;5145.819896303611;5146.665466744649;5181.145111056633;4622.399088118657;4647.302904564207;4659.836905708284;4806.351142595845;4819.156647586588;4858.5384388483035;4874.90250194987;4887.926681099858;4922.261660750916;4942.802287908444;4956.752162391938;4959.132151873336;4959.330490383752;4964.950350496449;4973.452920178705;4864.440589332272;4875.780589873535;4941.827036053721;4950.579200767831;4973.229149481836;4973.229149481836;4990.625703072356;4992.151334273255;4992.825251116194;5046.520580544842;4910.607151427948;4927.1131196384995;4930.556249937523;4958.479359667327;4980.626453016111;4910.656254062182;4985.202367621163;5028.899422011613;5034.370703662043;5057.342545469065;4920.852374428773;4952.77712502931;4959.801607935642;4962.305277261258;5001.024800164078 05:17:30 INFO - PROCESS | 18447 | |1;ext.html;574.8610007942813;579.4379451931626;597.6025942748073;604.4016423740499;607.762972440748;28690.856545717295;42127.57872421275;42967.140657186836;43079.692030796905;47755;43214.35178472318;43912.560874391245;43992.78003609977;44050.33924491135;44124.55875441253;7512.699492020312;7679.001729775121;7685.11621163565;7692.730754423596;7827.569483678395;7602.885956710654;9955.153811925959;10158.54286557103;10187.54156062979;10529.6314628988;10268.589256429734;10323.793524129513;10325.277230593862;10327.63853265136;10331.431771252579;7606.201348858345;10040.497975101216;10189.184865210766;10261.179105671567;10263.486825658762;9707.126358627758;9777.071178238057;9777.168940640055;9778.853317200248;9782.217422606174;39523.40714889279;39652.40521392181;39826.80086599549;39884.80057599722;39930.800345998374;2887.3792134691143;3010.32267739759;3107.425126351632;3152.2277042124824;3535.3636345457808;29542.852285738434;30053.398932021457;30162;30730.539041914388;30756.539476841797;3195.7443404527817;3199.392115498048;3210.2776875203126;3241.659625739287;3324.202191474029;245457;246107.76946115334;247793.7610311937;248250;248446;34021.829890850386;34823.303533929684;58529;58678.706606466694;58804;36018.27963440717;36082.81958590243;36127;36148.27703445969;36245;13930.164190148624;14007.579772606838;14028.649283767783;14032.438702451991;14033.298335083206;10064.949675251577;10862.511186996604;10885.564577416973;11636.010939070104;11911.642650720492;8328.125546817619;8343.791405214919;8430.072692003874;8483.236508714246;8495.447795893248;3095.721385075354;3105.0840002199407;3110.0825256549374;3113.2061324362144;3140.544621029984;927.7912469694264;957.5355952363099;979.5200351827554;1021.9795604087876;1136.6930928649383;29092.709072909423;29194.41611167765;29297.414051718846;29560.704392955795;29745.553816692765;944.15498129174;1057.1965306367063;1071.8820929697727;1145.5360578965533;1171.1509155862102;15010.924945375204;15564.844351556567;15651.530454086396;15656.373745050298;15935.12356820386;382194;385079;386900;387181;387510;51145.23282150771;51585;51708.48291517112;51766;51790;1184.9723955294135;1308.784050631654;1314.1392387985884;1342.8187194728782;1343.8656134386483;27760.72239277662;29476.705232947395;29689.25776855596;29794.70205297919;30182.396352073276;43567.56432435635;43638;44251.33622995593;44298.778506107265;44306.77846610746;292904;294914;295164;295206;295232;22913.65629515525;24933.376665583506;26006.34984125412;26156.738432616192;27323.31691707723;43414.78292608643;45126.54873451355;46289;47306.76346618245;49843.25235121403;38165;38191.61808381881;38575.6142438572;38613.80693096516;39027.41458878062;37239.50392649857;37472.625273748;37602;37976.62023379731;38182;36489.63510364862;36557.45163822491;36814.44778328274;37168.25663486769;37194.44208336823;32482.35035299328;34015.829920850236;34085.31829363349;34099.82950085333;34165.829170853984;25674.358141045876;25700;25937;26022.73977260203;26044.479110417305 05:17:30 INFO - PROCESS | 18447 | |2;jquery.html;378.3284669711262;382.91001614620575;391.8589307849174;397.8289335585697;403.60245158518853;15754.606134846621;17430.38993635223;18098;18134.727979080308;18146.637067258664;16370.427035053775;16427.67144657109;17006.744898826528;17195.742063869053;17589.64820703585;5056.342675452195;5173.793048278064;5182.455842136578;5183.766730497118;5232.633715639907;3590.461430785377;4838.419389673227;5915.112733090049;5918.615290006136;6035.245594300713;5838.620489668158;5923.970380148115;5975.731092100844;5986;5995.430434108753;5803.419658034205;5909.379515150912;5987.970060149715;6016.458518733291;6019.157317975487;5171.534561889448;5252.684838909678;5255.369355677305;5257.474252574751;5261.263423120728;20770;20897.268595599235;20906.37280881576;20927.37217883466;21303.25438609641;1904.628597423503;1912.1873203888292;1936.6804477261235;1962.5976674781637;2056.7840376760523;12874.098813083088;13168.473261069546;13209.141405808688;13266.469341226339;13737.862621373759;1797.8381945624956;1845.2342277954633;1922.5674223299786;1944.8346890514324;1972.1618312217395;68068;68239.9999999995;70036;70610;71968;10167.949160254151;10253.436061016566;10451.84322235167;10560.260781745357;10614;14395.352209150613;14421.92789036069;14505.274736263145;14512;14521;7562.810929726801;7774.183710710294;7807.258310460497;7902.209779022167;7945.64244608994;7507.21174276704;7513.812154696177;7524.623768811538;7621.123570789319;7632;4495.842645507391;4528.818847246139;4552.2488789350045;4555.612772914273;4557.134144512532;1889.9716504252447;1921.9519512012312;1926.489480287725;1927.2194761121768;1982.4350060232764;857.7984173719171;881.678187461572;882.9690960816469;903.5075883643431;948.4309414351334;16377.83622163787;16522.50432487027;17074.743878841826;17661.11694415274;19083.522911927314;904.326276923696;914.7804526913626;929.874466946967;933.8645896344992;979.2313034268066;9677.806443871083;9750.26872984529;10008.549615267184;10008.849867251996;10059.849102263472;396645;420516;421373;425330;425764;49813;75530.62234688792;76639;77071;90809;444.4977175791335;459.8896264896401;461.23895572305963;461.50157829543343;462.5305315105171;9726.173275271682;9930.05664461875;9973.451460169761;10290.588376465157;10735.248532602644;33696.35615428351;36975.26049479049;37565.624343756215;38117.23765524729;38747.225055498166;49721.25418118659;52322.72127344743;52516.212256815415;53528;54423.45576544184;7600.80997975055;7929.960350198212;7939.880901786593;7954.64204110828;7959.920400795918;8733.65065397377;11330.490127944098;11630.244034137753;11687.415629218674;12153.33156676356;10156.89843101589;10166.949165254126;10414.583416663248;10558;10579.259451838298;10061.295709300279;10236.385816851012;10327.225458090523;10331.845022324822;10366.844497332697;10464.796548397031;10682.83975740349;10752.247342686249;10863.891361086287;10867.456627168767;7744.225577442211;7833.725819596515;7835.098963619029;7870.173631768582;7974.561399122872;10114.494275286354;10467.581296748045;10552.630657926935;10669.35983840972;10677.786444270916 05:17:30 INFO - PROCESS | 18447 | |3;mootools.html;1327.7344531093784;1387.8265216847894;1492.0525466328882;1651.983480165198;1860.413969599576;7433.256674332571;7780.377569794417;7825.41309401795;7988.800279993003;7988.9600551997155;7744.26429489199;7924.603769811501;7945.046594408679;7954.443188976774;7965.880511792313;2266.750657427686;2289.748127705951;2291.7822806833324;2292.037344315383;2293.587154312223;2225.621644320461;2258.8080013198814;2285.988570057147;2286.9542609147807;2290.725112986444;2209.3924170853065;2212.3805334506283;2229.6321107017325;2232.229880691159;2237.2057919438607;2150.7956744109283;2168.186929901287;2182.9999999999923;2183.7816218378193;2185.5410363823617;2177.096504950444;2187.464071302541;2187.8796666183352;2188.2231807708195;2189.0805861538192;7558.659860306299;7779.72770953014;7783.182765809622;7866.0560732711865;7867.763967080997;4792.424909010941;4899.265110233458;4899.8040078396825;4900.509949005107;4907.681000734977;2861.1988643179943;2867.569864520318;2925.3564215872475;3012.2770535071427;3019.728224459809;911.2345629671108;923.3398120343986;927.2628260532892;937.5968333616543;943.556528431636;10592.523336449878;10681.35911845284;10683.679489615324;10684.946575267151;10699.572017119306;4136.131412403369;4237.576242375738;4281.443412356436;4291.420658211164;4314.89212769677;8528.232459078712;8559.529225892511;8564.700235491853;8566.78583035429;8573.442726222776;4626.467956185014;4740.6681532292405;4743.430788305425;4743.644226683013;4744.335792988984;3617.4573813928123;4104.958950410517;4212.789360531961;4216.515100763451;4409.581089796464;3427.657234276602;3433.9828300858335;3531.6998055165086;3531.8763843265874;3553.3248682750195;1029.5933106422922;1030.3817709374316;1035.9067683908484;1041.942693151884;1042.1714736784274;634.5494698763929;722.2741145149091;728.4754976416971;794.9006374203225;862.6894318045498;4882.145624515767;5092;5165.66423182492;5190.480951904779;5268.552173065255;470.240561493186;471.8957639124465;479.302614695617;490.65899200056333;620.8913440148046;3327.101682545699;3347.4978753187215;3362.9663703362653;3386.52588637586;3405.8637654494037;8629.309655227567;9032.283846088556;9047.366684332164;9088.409253398508;9147.2682185425;8962.596683149273;8994.550272486349;9036.593353299117;9054;9085.591148398338;6986.755463558751;7110.466714996396;7160.82097947545;7161.355478007004;7187.137543494814;4954.355933728592;4983.152864013199;5009.198528235464;5096.210087436453;5199.63602547818;8336.624851881801;8425.115362886809;8447.197516235949;8505.574721263789;8588.570571471526;8315.625796839036;8521.105283945097;8550.57247137653;8550.957245213734;8591.355648326275;5748.425157484218;5772.076467765138;5795.710214489174;5795.971020144872;5822.883542329215;6879.484038697017;6926.030355750299;6957.2694867038235;6958.338957799001;6962.651867406711;5710.857228569319;5957.821265362046;6555.508336874849;6649.368310010541;6888.41448476865;6645.700943457459;6776.7628133015105;6819;6863.142107236596;6903.378695917391;6427.0680751289865;6486.935130648633;6496.415322620798;6497.02544618311;6503.577267477788;4353.4122893408985;4436.0462500562535;4470.418845550058;4495.685302028826;4601.688518772134;4552.226121559409;4557.931631025471;4592.0815836833435;4681.929771053369;4703.858884233478 05:17:30 INFO - PROCESS | 18447 | |4;prototype.html;311.61982381494573;313.0764245475847;317.9523071539267;319.29913839123134;323.56480533682196;4792.424909010919;4829.22732362822;4836.129496690594;4838.419389673244;4848.975755121228;4757.833475828338;4765.785539650716;4782.6173906087515;4783.168999310704;4789.305550695147;3589.9641003590023;3700.3894357431127;3753.6434038766274;3843.48113004745;3872.7095467839886;3776.188119554295;3777.8299976501125;3822.44574536692;3827.7320587558884;3858.3633700439395;3535.1515636247373;3773.5094437723055;3774.641409066148;3775.509183806101;3796.753211041287;3660.304542136999;3743.2513497300647;3751.81240937952;3771;3781.9032480580736;3308.8511017004053;3310.5034244863223;3329.0845017620104;3337.599488061424;3341.031100980713;4549.363089167519;4578.175928332898;4609.354690343354;4622.422197225347;4624.421947256593;4180.7909604519655;4251.634581797956;4330.765731766432;4338.891527711801;4344.978275108636;4991.176455884774;5006.823396501855;5020.920502092068;5038.312165424587;5045.949540504585;3678.521792167028;3682.871099511531;3685.0603096210293;3689.1699367642336;3694.224212915291;4946.950530494685;5162.483751624807;5182;5301.496357845998;5302.269331294387;3701.3337599232395;3706.814659267026;3709.3323201823932;3719.683826874692;3745.1198968242443;3790.56408513019;3792.5259342582176;3798.24035192957;3799.316123097869;3803.8858834234466;4279.957200427956;4307.6338511226895;4315.158544083936;4318.963448772272;4325.351197320427;4760.809567617326;4983.950160498421;4997.425296090996;5011.874703132378;5077.568406685399;1309.9083064185415;1322.3388305847077;1325.3704490367;1327.2368388176837;1327.5993826513122;843.5487014447241;870.3994243971639;914.6204325205099;920.9907900921039;927.5501381829807;4323.416338794285;4400.889977750582;4419.624331931757;4430.911381772346;4431.578999994996;5097.719625420564;5110.872228194325;5111.693298402108;5123.154679477844;5150.150225212873;4214.936775948363;4375.584319489643;4385.122975404868;4399.1641588098155;4406.911861762746;2685.1407549584337;2699.25770413138;2703.810733248693;2723.978508059478;2735;4772.7136371817805;4782.497837727058;4782.689125206851;4783.182390691515;4801.327814106028;4973.825916092992;5148.459411761711;5178.81874134411;5195.272661827347;5261.263423120766;4871.610271178297;4875.780589873464;4880.316290879641;4884.462709102067;4896.2410826321975;5197.194434862602;5200.297959775382;5206.739663016759;5206.97396513015;5213.452587478412;4924.679895806761;5078.238264260242;5125.282460455614;5146.974265128651;5165.354330708661;4843.07981483517;4871.48849370811;4880.755962201947;4882.340883980617;4887.657863949489;3683.557973043252;3695.427208782643;3704.24063067076;3708.6291370862696;3725.7950812705562;4929.704217746947;5159.406668233201;5193.584513238856;5212.758513839086;5228;4970.975145124251;4985.9501404985485;4996.200607902718;4996.750162491933;5004.974975125101;5008.298838162733;5015.498450154955;5028;5034.773435195499;5053.216751403538;4791.113643975876;4941.481144479922;4941.851744447672;4994.825181118644;5019.3976722793495;4818.4217893852965;4963.8262660806695;5051.898962020812;5076.289319495348;5076.796928122833;4909.1899836528;4934.358533390637;4955.479674634112;5007.424146223086;5020.397552293748 05:17:30 INFO - PROCESS | 18447 | |5;yui.html;750.4746677325872;807.045826554379;812.695239285268;815.3029160068141;819.5287709567001;12637.494500219991;12904.483820647187;12930.547430839923;12946.935265323673;12961.740765184692;12276.815847762291;12279.324637144953;12284.508619655226;12313.261204327724;12314.630561083159;673.7473447457204;840.4873027453249;852.9701460448902;863.3309185381348;871.4727589808169;848.406115718996;852.6845067325067;854.3378881366929;855.5209082913589;856.8157846063095;595.1132812109946;597.0596310810491;597.3638075449654;598.6378241164099;598.8443004818735;683.6855046678534;890.6971629645919;911.1571796088658;913.9451632902047;916.706653870755;676.668432468092;676.6853413162903;677.3734295776387;677.6273049822627;677.857649893523;12809.935950320189;12866.163699359511;12873.485060597564;12901.419436125398;12941.417636206394;11776.705582360424;11959.641210763692;11993;12047.819282710767;12055.638330850088;10613.363198208132;10760.461976901124;10793.08258798003;11051.778964420748;11089.778204435866;4169.958300417018;4171.7496950182785;4194.559571245006;4232.470941132358;4276.807543660511;39733.60266397328;41246.587534124876;41949.370759438636;41989.37015944763;42378;9246.907530924605;9351.625934962662;9449.858252126223;9471;9871.654492092743;17003.31986720542;17066.829331706773;17132.486025419257;17208.741868871977;17274.827251727573;6232.56372053961;6400.359964003563;6411.903821442682;6449.774257900951;6581.407673309425;3656.7988760618423;3688.4098544232793;3690.7970061646865;3775.075106598846;3798.3352913240074;2717.9943420934383;2792.357757715696;2795.6645202575414;2798.2864369585627;2799.664040315175;417.4760675352413;495.47974626642605;512.9230615407719;512.9717865517358;533.842516457646;446.92626214364725;523.7459831981486;542.9809956651499;550.4165584480463;553.5599198637093;7376.7418140364825;7512.962435187898;7646.732364367221;7788.065432148179;7862.488938218998;517.8575891629832;549.3572520151353;615.4245780195531;627.2629660149397;628.8710814283061;3800.1829606634155;3920.313945059603;3950.367941129463;4014.1770936957855;4054.3310353791885;54004.45995539994;56202.71898640563;56895.43104568984;56981.43018569844;57124.71437642868;39868.800655996536;42337.364939525934;42598.78700606477;46003.30995035077;50163.24755128676;41816.790916045225;43339;43413.78293108577;43608.78195609065;44329.335059974124;7022.40309573692;8219.424640275363;8397.70608028716;8440.662373505236;8565.700200492953;28544.286392840346;28768.856155719088;30023.249418763833;30135.547966780956;30175.698243018167;38271.42592861165;38838.6116138835;38846.41730374103;38893.416598750475;38914.83255502339;9301.534923253676;9375.24998000172;9387.342885997914;9400.34197606161;9401.200897923753;9706.951465242912;10076.3282862187;10177.287589868638;10256.743581410525;10675.57297708083;9665.71002869915;9668.75828104303;9713.465759383302;9969.152622027208;9979.50102494887;9684.70945871625;9854.901450985399;9895.455749933823;9964.800703985735;10147.49262536885;9640.228781697308;9753.853692194765;9913;10049.995000499892;10248.692539223835;8394.118617545315;8414.326853851555;8424.368172387218;8681.565921704016;8746.562671866253;8601.618126181926;8642.654293828176;8683.522406267715;8813.603387847434;8852.513111778913 05:17:30 INFO - PROCESS | 18447 | __end_tp_report 05:17:30 INFO - PROCESS | 18447 | __start_cc_report 05:17:30 INFO - PROCESS | 18447 | _x_x_mozilla_cycle_collect,1061 05:17:30 INFO - PROCESS | 18447 | __end_cc_report 05:17:30 INFO - PROCESS | 18447 | __startTimestamp1462882650620__endTimestamp 05:17:30 INFO - PROCESS | 18447 | 05:17:30 INFO - PROCESS | 18447 | ------- Summary: start ------- 05:17:30 INFO - PROCESS | 18447 | Number of tests: 6 05:17:30 INFO - PROCESS | 18447 | 05:17:30 INFO - PROCESS | 18447 | [#0] dojo.html Cycles:165 Average:4689.09 Median:4819.16 stddev:475.55 (9.9%) stddev-sans-first:449.16 05:17:30 INFO - PROCESS | 18447 | Values: 2644.9 2651.0 2695.5 2706.7 2712.7 4617.4 4677.3 4710.2 4770.5 4808.3 4751.3 4756.4 4766.0 4801.5 4805.6 4333.1 4367.8 4409.8 4434.4 4513.9 4425.2 4463.7 4475.5 4479.0 4499.4 4279.9 4299.1 4346.3 4350.9 4366.2 4286.6 4398.8 4400.5 4409.5 4454.6 4384.1 4398.9 4399.3 4426.0 4440.6 4479.1 4557.8 4597.0 4605.5 4661.3 5007.4 5029.9 5074.7 5076.7 5079.9 4876.0 5077.1 5107.8 5113.5 5127.4 4686.7 4739.0 4740.0 4740.0 4742.4 5112.5 5187.1 5188.4 5192.9 5210.4 4906.2 4931.5 4958.0 4990.1 5001.9 5034.3 5040.5 5057.5 5111.6 5119.5 5007.7 5014.9 5020.5 5022.5 5067.3 4848.8 5000.9 5025.7 5031.8 5033.5 4383.9 4404.3 4410.8 4434.5 4453.7 3791.7 3798.8 3805.0 3822.6 3840.3 4235.0 4287.3 4386.4 4392.4 4425.5 4983.6 5039.5 5043.1 5050.5 5063.1 4329.5 4331.8 4331.9 4341.8 4374.3 4492.0 4580.3 4585.9 4627.8 4646.1 4798.6 4810.4 4814.3 4828.4 4863.0 5142.6 5144.4 5145.8 5146.7 5181.1 4622.4 4647.3 4659.8 4806.4 4819.2 4858.5 4874.9 4887.9 4922.3 4942.8 4956.8 4959.1 4959.3 4965.0 4973.5 4864.4 4875.8 4941.8 4950.6 4973.2 4973.2 4990.6 4992.2 4992.8 5046.5 4910.6 4927.1 4930.6 4958.5 4980.6 4910.7 4985.2 5028.9 5034.4 5057.3 4920.9 4952.8 4959.8 4962.3 5001.0 05:17:30 INFO - PROCESS | 18447 | 05:17:30 INFO - PROCESS | 18447 | [#1] ext.html Cycles:180 Average:46559.12 Median:34053.57 stddev:82733.40 (243.0%) stddev-sans-first:82893.45 05:17:30 INFO - PROCESS | 18447 | Values: 574.9 579.4 597.6 604.4 607.8 28690.9 42127.6 42967.1 43079.7 47755.0 43214.4 43912.6 43992.8 44050.3 44124.6 7512.7 7679.0 7685.1 7692.7 7827.6 7602.9 9955.2 10158.5 10187.5 10529.6 10268.6 10323.8 10325.3 10327.6 10331.4 7606.2 10040.5 10189.2 10261.2 10263.5 9707.1 9777.1 9777.2 9778.9 9782.2 39523.4 39652.4 39826.8 39884.8 39930.8 2887.4 3010.3 3107.4 3152.2 3535.4 29542.9 30053.4 30162.0 30730.5 30756.5 3195.7 3199.4 3210.3 3241.7 3324.2 245457.0 246107.8 247793.8 248250.0 248446.0 34021.8 34823.3 58529.0 58678.7 58804.0 36018.3 36082.8 36127.0 36148.3 36245.0 13930.2 14007.6 14028.6 14032.4 14033.3 10064.9 10862.5 10885.6 11636.0 11911.6 8328.1 8343.8 8430.1 8483.2 8495.4 3095.7 3105.1 3110.1 3113.2 3140.5 927.8 957.5 979.5 1022.0 1136.7 29092.7 29194.4 29297.4 29560.7 29745.6 944.2 1057.2 1071.9 1145.5 1171.2 15010.9 15564.8 15651.5 15656.4 15935.1 382194.0 385079.0 386900.0 387181.0 387510.0 51145.2 51585.0 51708.5 51766.0 51790.0 1185.0 1308.8 1314.1 1342.8 1343.9 27760.7 29476.7 29689.3 29794.7 30182.4 43567.6 43638.0 44251.3 44298.8 44306.8 292904.0 294914.0 295164.0 295206.0 295232.0 22913.7 24933.4 26006.3 26156.7 27323.3 43414.8 45126.5 46289.0 47306.8 49843.3 38165.0 38191.6 38575.6 38613.8 39027.4 37239.5 37472.6 37602.0 37976.6 38182.0 36489.6 36557.5 36814.4 37168.3 37194.4 32482.4 34015.8 34085.3 34099.8 34165.8 25674.4 25700.0 25937.0 26022.7 26044.5 05:17:30 INFO - PROCESS | 18447 | 05:17:30 INFO - PROCESS | 18447 | [#2] jquery.html Cycles:180 Average:25186.45 Median:210459.80 stddev:68832.61 (32.7%) stddev-sans-first:69000.50 05:17:30 INFO - PROCESS | 18447 | Values: 378.3 382.9 391.9 397.8 403.6 15754.6 17430.4 18098.0 18134.7 18146.6 16370.4 16427.7 17006.7 17195.7 17589.6 5056.3 5173.8 5182.5 5183.8 5232.6 3590.5 4838.4 5915.1 5918.6 6035.2 5838.6 5924.0 5975.7 5986.0 5995.4 5803.4 5909.4 5988.0 6016.5 6019.2 5171.5 5252.7 5255.4 5257.5 5261.3 20770.0 20897.3 20906.4 20927.4 21303.3 1904.6 1912.2 1936.7 1962.6 2056.8 12874.1 13168.5 13209.1 13266.5 13737.9 1797.8 1845.2 1922.6 1944.8 1972.2 68068.0 68240.0 70036.0 70610.0 71968.0 10167.9 10253.4 10451.8 10560.3 10614.0 14395.4 14421.9 14505.3 14512.0 14521.0 7562.8 7774.2 7807.3 7902.2 7945.6 7507.2 7513.8 7524.6 7621.1 7632.0 4495.8 4528.8 4552.2 4555.6 4557.1 1890.0 1922.0 1926.5 1927.2 1982.4 857.8 881.7 883.0 903.5 948.4 16377.8 16522.5 17074.7 17661.1 19083.5 904.3 914.8 929.9 933.9 979.2 9677.8 9750.3 10008.5 10008.8 10059.8 396645.0 420516.0 421373.0 425330.0 425764.0 49813.0 75530.6 76639.0 77071.0 90809.0 444.5 459.9 461.2 461.5 462.5 9726.2 9930.1 9973.5 10290.6 10735.2 33696.4 36975.3 37565.6 38117.2 38747.2 49721.3 52322.7 52516.2 53528.0 54423.5 7600.8 7930.0 7939.9 7954.6 7959.9 8733.7 11330.5 11630.2 11687.4 12153.3 10156.9 10166.9 10414.6 10558.0 10579.3 10061.3 10236.4 10327.2 10331.8 10366.8 10464.8 10682.8 10752.2 10863.9 10867.5 7744.2 7833.7 7835.1 7870.2 7974.6 10114.5 10467.6 10552.6 10669.4 10677.8 05:17:30 INFO - PROCESS | 18447 | 05:17:30 INFO - PROCESS | 18447 | [#3] mootools.html Cycles:180 Average:5002.68 Median:4968.75 stddev:2765.55 (55.7%) stddev-sans-first:2759.52 05:17:30 INFO - PROCESS | 18447 | Values: 1327.7 1387.8 1492.1 1652.0 1860.4 7433.3 7780.4 7825.4 7988.8 7989.0 7744.3 7924.6 7945.0 7954.4 7965.9 2266.8 2289.7 2291.8 2292.0 2293.6 2225.6 2258.8 2286.0 2287.0 2290.7 2209.4 2212.4 2229.6 2232.2 2237.2 2150.8 2168.2 2183.0 2183.8 2185.5 2177.1 2187.5 2187.9 2188.2 2189.1 7558.7 7779.7 7783.2 7866.1 7867.8 4792.4 4899.3 4899.8 4900.5 4907.7 2861.2 2867.6 2925.4 3012.3 3019.7 911.2 923.3 927.3 937.6 943.6 10592.5 10681.4 10683.7 10684.9 10699.6 4136.1 4237.6 4281.4 4291.4 4314.9 8528.2 8559.5 8564.7 8566.8 8573.4 4626.5 4740.7 4743.4 4743.6 4744.3 3617.5 4105.0 4212.8 4216.5 4409.6 3427.7 3434.0 3531.7 3531.9 3553.3 1029.6 1030.4 1035.9 1041.9 1042.2 634.5 722.3 728.5 794.9 862.7 4882.1 5092.0 5165.7 5190.5 5268.6 470.2 471.9 479.3 490.7 620.9 3327.1 3347.5 3363.0 3386.5 3405.9 8629.3 9032.3 9047.4 9088.4 9147.3 8962.6 8994.6 9036.6 9054.0 9085.6 6986.8 7110.5 7160.8 7161.4 7187.1 4954.4 4983.2 5009.2 5096.2 5199.6 8336.6 8425.1 8447.2 8505.6 8588.6 8315.6 8521.1 8550.6 8551.0 8591.4 5748.4 5772.1 5795.7 5796.0 5822.9 6879.5 6926.0 6957.3 6958.3 6962.7 5710.9 5957.8 6555.5 6649.4 6888.4 6645.7 6776.8 6819.0 6863.1 6903.4 6427.1 6486.9 6496.4 6497.0 6503.6 4353.4 4436.0 4470.4 4495.7 4601.7 4552.2 4557.9 4592.1 4681.9 4703.9 05:17:30 INFO - PROCESS | 18447 | 05:17:30 INFO - PROCESS | 18447 | [#4] prototype.html Cycles:180 Average:4177.80 Median:4782.65 stddev:1193.72 (25.0%) stddev-sans-first:1161.26 05:17:30 INFO - PROCESS | 18447 | Values: 311.6 313.1 318.0 319.3 323.6 4792.4 4829.2 4836.1 4838.4 4849.0 4757.8 4765.8 4782.6 4783.2 4789.3 3590.0 3700.4 3753.6 3843.5 3872.7 3776.2 3777.8 3822.4 3827.7 3858.4 3535.2 3773.5 3774.6 3775.5 3796.8 3660.3 3743.3 3751.8 3771.0 3781.9 3308.9 3310.5 3329.1 3337.6 3341.0 4549.4 4578.2 4609.4 4622.4 4624.4 4180.8 4251.6 4330.8 4338.9 4345.0 4991.2 5006.8 5020.9 5038.3 5045.9 3678.5 3682.9 3685.1 3689.2 3694.2 4947.0 5162.5 5182.0 5301.5 5302.3 3701.3 3706.8 3709.3 3719.7 3745.1 3790.6 3792.5 3798.2 3799.3 3803.9 4280.0 4307.6 4315.2 4319.0 4325.4 4760.8 4984.0 4997.4 5011.9 5077.6 1309.9 1322.3 1325.4 1327.2 1327.6 843.5 870.4 914.6 921.0 927.6 4323.4 4400.9 4419.6 4430.9 4431.6 5097.7 5110.9 5111.7 5123.2 5150.2 4214.9 4375.6 4385.1 4399.2 4406.9 2685.1 2699.3 2703.8 2724.0 2735.0 4772.7 4782.5 4782.7 4783.2 4801.3 4973.8 5148.5 5178.8 5195.3 5261.3 4871.6 4875.8 4880.3 4884.5 4896.2 5197.2 5200.3 5206.7 5207.0 5213.5 4924.7 5078.2 5125.3 5147.0 5165.4 4843.1 4871.5 4880.8 4882.3 4887.7 3683.6 3695.4 3704.2 3708.6 3725.8 4929.7 5159.4 5193.6 5212.8 5228.0 4971.0 4986.0 4996.2 4996.8 5005.0 5008.3 5015.5 5028.0 5034.8 5053.2 4791.1 4941.5 4941.9 4994.8 5019.4 4818.4 4963.8 5051.9 5076.3 5076.8 4909.2 4934.4 4955.5 5007.4 5020.4 05:17:30 INFO - PROCESS | 18447 | 05:17:30 INFO - PROCESS | 18447 | [#5] yui.html Cycles:180 Average:12512.90 Median:27273.72 stddev:14425.31 (52.9%) stddev-sans-first:14438.74 05:17:30 INFO - PROCESS | 18447 | Values: 750.5 807.0 812.7 815.3 819.5 12637.5 12904.5 12930.5 12946.9 12961.7 12276.8 12279.3 12284.5 12313.3 12314.6 673.7 840.5 853.0 863.3 871.5 848.4 852.7 854.3 855.5 856.8 595.1 597.1 597.4 598.6 598.8 683.7 890.7 911.2 913.9 916.7 676.7 676.7 677.4 677.6 677.9 12809.9 12866.2 12873.5 12901.4 12941.4 11776.7 11959.6 11993.0 12047.8 12055.6 10613.4 10760.5 10793.1 11051.8 11089.8 4170.0 4171.7 4194.6 4232.5 4276.8 39733.6 41246.6 41949.4 41989.4 42378.0 9246.9 9351.6 9449.9 9471.0 9871.7 17003.3 17066.8 17132.5 17208.7 17274.8 6232.6 6400.4 6411.9 6449.8 6581.4 3656.8 3688.4 3690.8 3775.1 3798.3 2718.0 2792.4 2795.7 2798.3 2799.7 417.5 495.5 512.9 513.0 533.8 446.9 523.7 543.0 550.4 553.6 7376.7 7513.0 7646.7 7788.1 7862.5 517.9 549.4 615.4 627.3 628.9 3800.2 3920.3 3950.4 4014.2 4054.3 54004.5 56202.7 56895.4 56981.4 57124.7 39868.8 42337.4 42598.8 46003.3 50163.2 41816.8 43339.0 43413.8 43608.8 44329.3 7022.4 8219.4 8397.7 8440.7 8565.7 28544.3 28768.9 30023.2 30135.5 30175.7 38271.4 38838.6 38846.4 38893.4 38914.8 9301.5 9375.2 9387.3 9400.3 9401.2 9707.0 10076.3 10177.3 10256.7 10675.6 9665.7 9668.8 9713.5 9969.2 9979.5 9684.7 9854.9 9895.5 9964.8 10147.5 9640.2 9753.9 9913.0 10050.0 10248.7 8394.1 8414.3 8424.4 8681.6 8746.6 8601.6 8642.7 8683.5 8813.6 8852.5 05:17:30 INFO - PROCESS | 18447 | -------- Summary: end -------- 05:17:30 INFO - PROCESS | 18447 | 05:17:31 INFO - TEST-INFO | 18447: exit 0 05:17:31 INFO - TEST-OK | dromaeo_css | took 1119022ms 05:17:31 INFO - TEST-START | kraken 05:17:31 INFO - operating with platform_type : linux_ 05:17:31 INFO - Initialising browser for kraken test... 05:17:31 INFO - TEST-INFO | started process 18625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmJLkR6/profile http://localhost:48774/getInfo.html) 05:17:36 INFO - PROCESS | 18625 | __metrics Screen width/height:1600/1200 05:17:36 INFO - PROCESS | 18625 | colorDepth:24 05:17:36 INFO - PROCESS | 18625 | Browser inner width/height: 1024/697 05:17:36 INFO - PROCESS | 18625 | __metrics 05:17:37 ERROR - PROCESS | 18625 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:17:38 INFO - TEST-INFO | 18625: exit 0 05:17:38 INFO - Browser initialized. 05:17:38 INFO - Running cycle 1/1 for kraken test... 05:17:38 INFO - TEST-INFO | started process 18706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmJLkR6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:50 INFO - PROCESS | 18706 | RSS: Main: 153690112 05:17:50 INFO - PROCESS | 18706 | 05:17:52 INFO - PROCESS | 18706 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48774/tests/kraken/driver.html?testName=audio-beat-detection) 05:17:53 INFO - PROCESS | 18706 | RSS: Main: 209600512 05:17:53 INFO - PROCESS | 18706 | 05:17:56 INFO - PROCESS | 18706 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48774/tests/kraken/driver.html?testName=audio-dft) 05:17:57 INFO - PROCESS | 18706 | RSS: Main: 197599232 05:17:57 INFO - PROCESS | 18706 | 05:18:00 INFO - PROCESS | 18706 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48774/tests/kraken/driver.html?testName=audio-fft) 05:18:01 INFO - PROCESS | 18706 | RSS: Main: 266121216 05:18:01 INFO - PROCESS | 18706 | 05:18:03 INFO - PROCESS | 18706 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48774/tests/kraken/driver.html?testName=audio-oscillator) 05:18:04 INFO - PROCESS | 18706 | RSS: Main: 175726592 05:18:04 INFO - PROCESS | 18706 | 05:18:06 INFO - PROCESS | 18706 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48774/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:18:07 INFO - PROCESS | 18706 | RSS: Main: 178868224 05:18:07 INFO - PROCESS | 18706 | 05:18:10 INFO - PROCESS | 18706 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48774/tests/kraken/driver.html?testName=imaging-darkroom) 05:18:11 INFO - PROCESS | 18706 | RSS: Main: 215724032 05:18:11 INFO - PROCESS | 18706 | 05:18:14 INFO - PROCESS | 18706 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48774/tests/kraken/driver.html?testName=imaging-desaturate) 05:18:15 INFO - PROCESS | 18706 | RSS: Main: 213438464 05:18:15 INFO - PROCESS | 18706 | 05:18:18 INFO - PROCESS | 18706 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48774/tests/kraken/driver.html?testName=json-parse-financial) 05:18:19 INFO - PROCESS | 18706 | RSS: Main: 214769664 05:18:19 INFO - PROCESS | 18706 | 05:18:20 INFO - PROCESS | 18706 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48774/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:18:21 INFO - PROCESS | 18706 | RSS: Main: 202149888 05:18:21 INFO - PROCESS | 18706 | 05:18:23 INFO - PROCESS | 18706 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48774/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:18:24 INFO - PROCESS | 18706 | RSS: Main: 206577664 05:18:24 INFO - PROCESS | 18706 | 05:18:26 INFO - PROCESS | 18706 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48774/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:18:27 INFO - PROCESS | 18706 | RSS: Main: 215515136 05:18:27 INFO - PROCESS | 18706 | 05:18:29 INFO - PROCESS | 18706 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:18:30 INFO - PROCESS | 18706 | RSS: Main: 220004352 05:18:30 INFO - PROCESS | 18706 | 05:18:33 INFO - PROCESS | 18706 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:18:34 INFO - PROCESS | 18706 | RSS: Main: 218980352 05:18:34 INFO - PROCESS | 18706 | 05:18:36 INFO - PROCESS | 18706 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48774/tests/kraken/driver.html?testName=ai-astar) 05:18:36 INFO - PROCESS | 18706 | RSS: Main: 265838592 05:18:36 INFO - PROCESS | 18706 | 05:18:36 INFO - PROCESS | 18706 | __start_tp_report 05:18:36 INFO - PROCESS | 18706 | _x_x_mozilla_page_load 05:18:36 INFO - PROCESS | 18706 | _x_x_mozilla_page_load_details 05:18:36 INFO - PROCESS | 18706 | |i|pagename|runs| 05:18:36 INFO - PROCESS | 18706 | |0;ai-astar;114;111;112;113;114;113;112;115;115;114 05:18:36 INFO - PROCESS | 18706 | |1;audio-beat-detection;156;134;159;227;133;162;153;138;181;140 05:18:36 INFO - PROCESS | 18706 | |2;audio-dft;162;160;160;161;160;160;162;161;158;159 05:18:36 INFO - PROCESS | 18706 | |3;audio-fft;78;78;78;163;77;78;77;77;130;75 05:18:36 INFO - PROCESS | 18706 | |4;audio-oscillator;94;95;154;93;92;93;128;93;93;126 05:18:36 INFO - PROCESS | 18706 | |5;imaging-gaussian-blur;117;117;116;116;119;116;116;117;117;117 05:18:36 INFO - PROCESS | 18706 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;146;147 05:18:36 INFO - PROCESS | 18706 | |7;imaging-desaturate;94;94;94;94;95;95;94;94;95;95 05:18:36 INFO - PROCESS | 18706 | |8;json-parse-financial;67;68;67;67;68;68;68;120;65;65 05:18:36 INFO - PROCESS | 18706 | |9;json-stringify-tinderbox;63;64;64;64;63;64;64;65;65;63 05:18:36 INFO - PROCESS | 18706 | |10;stanford-crypto-aes;88;87;83;83;83;83;88;85;87;89 05:18:36 INFO - PROCESS | 18706 | |11;stanford-crypto-ccm;151;133;133;138;129;139;130;133;256;138 05:18:36 INFO - PROCESS | 18706 | |12;stanford-crypto-pbkdf2;184;175;176;175;175;176;172;179;173;178 05:18:36 INFO - PROCESS | 18706 | |13;stanford-crypto-sha256-iterative;71;68;70;69;70;69;66;67;66;66 05:18:36 INFO - PROCESS | 18706 | __end_tp_report 05:18:36 INFO - PROCESS | 18706 | __start_cc_report 05:18:36 INFO - PROCESS | 18706 | _x_x_mozilla_cycle_collect,2074 05:18:36 INFO - PROCESS | 18706 | __end_cc_report 05:18:36 INFO - PROCESS | 18706 | __startTimestamp1462882716275__endTimestamp 05:18:36 INFO - PROCESS | 18706 | 05:18:36 INFO - PROCESS | 18706 | ------- Summary: start ------- 05:18:36 INFO - PROCESS | 18706 | Number of tests: 14 05:18:36 INFO - PROCESS | 18706 | 05:18:36 INFO - PROCESS | 18706 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:1.34 (1.2%) stddev-sans-first:1.39 05:18:36 INFO - PROCESS | 18706 | Values: 114.0 111.0 112.0 113.0 114.0 113.0 112.0 115.0 115.0 114.0 05:18:36 INFO - PROCESS | 18706 | 05:18:36 INFO - PROCESS | 18706 | [#1] audio-beat-detection Cycles:10 Average:158.30 Median:157.50 stddev:28.40 (18.0%) stddev-sans-first:30.11 05:18:36 INFO - PROCESS | 18706 | Values: 156.0 134.0 159.0 227.0 133.0 162.0 153.0 138.0 181.0 140.0 05:18:36 INFO - PROCESS | 18706 | 05:18:36 INFO - PROCESS | 18706 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:1.25 (0.8%) stddev-sans-first:1.17 05:18:36 INFO - PROCESS | 18706 | Values: 162.0 160.0 160.0 161.0 160.0 160.0 162.0 161.0 158.0 159.0 05:18:36 INFO - PROCESS | 18706 | 05:18:36 INFO - PROCESS | 18706 | [#3] audio-fft Cycles:10 Average:91.10 Median:77.50 stddev:30.23 (39.0%) stddev-sans-first:31.69 05:18:36 INFO - PROCESS | 18706 | Values: 78.0 78.0 78.0 163.0 77.0 78.0 77.0 77.0 130.0 75.0 05:18:36 INFO - PROCESS | 18706 | 05:18:36 INFO - PROCESS | 18706 | [#4] audio-oscillator Cycles:10 Average:106.10 Median:93.00 stddev:21.92 (23.6%) stddev-sans-first:22.81 05:18:36 INFO - PROCESS | 18706 | Values: 94.0 95.0 154.0 93.0 92.0 93.0 128.0 93.0 93.0 126.0 05:18:36 INFO - PROCESS | 18706 | 05:18:36 INFO - PROCESS | 18706 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 05:18:36 INFO - PROCESS | 18706 | Values: 117.0 117.0 116.0 116.0 119.0 116.0 116.0 117.0 117.0 117.0 05:18:36 INFO - PROCESS | 18706 | 05:18:36 INFO - PROCESS | 18706 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 05:18:36 INFO - PROCESS | 18706 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 05:18:36 INFO - PROCESS | 18706 | 05:18:36 INFO - PROCESS | 18706 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:18:36 INFO - PROCESS | 18706 | Values: 94.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 05:18:36 INFO - PROCESS | 18706 | 05:18:36 INFO - PROCESS | 18706 | [#8] json-parse-financial Cycles:10 Average:72.30 Median:67.50 stddev:16.80 (24.9%) stddev-sans-first:17.71 05:18:36 INFO - PROCESS | 18706 | Values: 67.0 68.0 67.0 67.0 68.0 68.0 68.0 120.0 65.0 65.0 05:18:36 INFO - PROCESS | 18706 | 05:18:36 INFO - PROCESS | 18706 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 05:18:36 INFO - PROCESS | 18706 | Values: 63.0 64.0 64.0 64.0 63.0 64.0 64.0 65.0 65.0 63.0 05:18:36 INFO - PROCESS | 18706 | 05:18:36 INFO - PROCESS | 18706 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:87.00 stddev:2.46 (2.8%) stddev-sans-first:2.45 05:18:36 INFO - PROCESS | 18706 | Values: 88.0 87.0 83.0 83.0 83.0 83.0 88.0 85.0 87.0 89.0 05:18:36 INFO - PROCESS | 18706 | 05:18:36 INFO - PROCESS | 18706 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:138.00 stddev:38.46 (27.9%) stddev-sans-first:40.78 05:18:36 INFO - PROCESS | 18706 | Values: 151.0 133.0 133.0 138.0 129.0 139.0 130.0 133.0 256.0 138.0 05:18:36 INFO - PROCESS | 18706 | 05:18:36 INFO - PROCESS | 18706 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:176.00 stddev:3.40 (1.9%) stddev-sans-first:2.19 05:18:36 INFO - PROCESS | 18706 | Values: 184.0 175.0 176.0 175.0 175.0 176.0 172.0 179.0 173.0 178.0 05:18:36 INFO - PROCESS | 18706 | 05:18:36 INFO - PROCESS | 18706 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:1.87 (2.7%) stddev-sans-first:1.69 05:18:36 INFO - PROCESS | 18706 | Values: 71.0 68.0 70.0 69.0 70.0 69.0 66.0 67.0 66.0 66.0 05:18:36 INFO - PROCESS | 18706 | -------- Summary: end -------- 05:18:36 INFO - PROCESS | 18706 | 05:18:37 INFO - TEST-INFO | 18706: exit 0 05:18:37 INFO - TEST-OK | kraken | took 66010ms 05:18:37 INFO - SUITE-END | took 1185s 05:18:37 INFO - Completed test suite (00:19:45) 05:18:37 INFO - javascript benchmark 05:18:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2644.9338766530836, 2651.0323731837884, 2695.5417579011564, 2706.6751989761233, 2712.7287271272876, 4617.353570500132, 4677.2750223715375, 4710.246360582308, 4770.451398089221, 4808.254720518321, 4751.3348131261655, 4756.405449318835, 4766.046790641877, 4801.495842936493, 4805.61555075594, 4333.11171209902, 4367.825286988516, 4409.757463339515, 4434.35701823237, 4513.864584062483, 4425.22558552252, 4463.73217606943, 4475.485319188286, 4478.97760511197, 4499.437570303712, 4279.871603851859, 4299.140171965588, 4346.282863327548, 4350.934735978963, 4366.170427618742, 4286.57134286572, 4398.824047038114, 4400.471943366784, 4409.49290831552, 4454.5990860822685, 4384.101259241847, 4398.912021759547, 4399.252127138362, 4426.026274219666, 4440.555944405566, 4479.104179164147, 4557.772111394417, 4596.954030459719, 4605.470370907355, 4661.324108004321, 5007.37407824022, 5029.949700502984, 5074.746262686888, 5076.695398276115, 5079.8984020319385, 4876.0, 5077.111505486525, 5107.846764597031, 5113.463086375914, 5127.435982041972, 4686.695364801277, 4738.952610473852, 4739.95260047402, 4739.976300118477, 4742.4309082909585, 5112.514311140436, 5187.0922588546855, 5188.429272779991, 5192.948070519322, 5210.400803907523, 4906.215005599087, 4931.457539670633, 4957.950420495821, 4990.10178167926, 5001.89996200074, 5034.270030845507, 5040.470750571138, 5057.544820966131, 5111.5655169310285, 5119.539241468211, 5007.7245751484015, 5014.874628134253, 5020.47285035066, 5022.497750225021, 5067.265246539231, 4848.8302909398, 5000.89998200034, 5025.698458092526, 5031.823886163967, 5033.471485494044, 4383.912321753547, 4404.2512772828695, 4410.823567057346, 4434.467863856358, 4453.732776033448, 3791.734578579473, 3798.848046078181, 3804.9809750951067, 3822.57951625321, 3840.30874442603, 4235.0, 4287.3140297552245, 4386.407834942306, 4392.38506609075, 4425.491068527096, 4983.626228032839, 5039.521245481674, 5043.092243396224, 5050.4697006814495, 5063.139266324733, 4329.545397733193, 4331.848385306499, 4331.935020974688, 4341.834594875285, 4374.300111982067, 4492.0, 4580.335851301543, 4585.862424127282, 4627.838025669085, 4646.094011667692, 4798.640101992295, 4810.39870016248, 4814.325994360863, 4828.37231159947, 4863.0, 5142.5885929126325, 5144.356955380577, 5145.819896303611, 5146.665466744649, 5181.145111056633, 4622.399088118657, 4647.302904564207, 4659.836905708284, 4806.351142595845, 4819.156647586588, 4858.5384388483035, 4874.90250194987, 4887.926681099858, 4922.261660750916, 4942.802287908444, 4956.752162391938, 4959.132151873336, 4959.330490383752, 4964.950350496449, 4973.452920178705, 4864.440589332272, 4875.780589873535, 4941.827036053721, 4950.579200767831, 4973.229149481836, 4973.229149481836, 4990.625703072356, 4992.151334273255, 4992.825251116194, 5046.520580544842, 4910.607151427948, 4927.1131196384995, 4930.556249937523, 4958.479359667327, 4980.626453016111, 4910.656254062182, 4985.202367621163, 5028.899422011613, 5034.370703662043, 5057.342545469065, 4920.852374428773, 4952.77712502931, 4959.801607935642, 4962.305277261258, 5001.024800164078], "value": 4659.681430826028, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.8610007942813, 579.4379451931626, 597.6025942748073, 604.4016423740499, 607.762972440748, 28690.856545717295, 42127.57872421275, 42967.140657186836, 43079.692030796905, 47755.0, 43214.35178472318, 43912.560874391245, 43992.78003609977, 44050.33924491135, 44124.55875441253, 7512.699492020312, 7679.001729775121, 7685.11621163565, 7692.730754423596, 7827.569483678395, 7602.885956710654, 9955.153811925959, 10158.54286557103, 10187.54156062979, 10529.6314628988, 10268.589256429734, 10323.793524129513, 10325.277230593862, 10327.63853265136, 10331.431771252579, 7606.201348858345, 10040.497975101216, 10189.184865210766, 10261.179105671567, 10263.486825658762, 9707.126358627758, 9777.071178238057, 9777.168940640055, 9778.853317200248, 9782.217422606174, 39523.40714889279, 39652.40521392181, 39826.80086599549, 39884.80057599722, 39930.800345998374, 2887.3792134691143, 3010.32267739759, 3107.425126351632, 3152.2277042124824, 3535.3636345457808, 29542.852285738434, 30053.398932021457, 30162.0, 30730.539041914388, 30756.539476841797, 3195.7443404527817, 3199.392115498048, 3210.2776875203126, 3241.659625739287, 3324.202191474029, 245457.0, 246107.76946115334, 247793.7610311937, 248250.0, 248446.0, 34021.829890850386, 34823.303533929684, 58529.0, 58678.706606466694, 58804.0, 36018.27963440717, 36082.81958590243, 36127.0, 36148.27703445969, 36245.0, 13930.164190148624, 14007.579772606838, 14028.649283767783, 14032.438702451991, 14033.298335083206, 10064.949675251577, 10862.511186996604, 10885.564577416973, 11636.010939070104, 11911.642650720492, 8328.125546817619, 8343.791405214919, 8430.072692003874, 8483.236508714246, 8495.447795893248, 3095.721385075354, 3105.0840002199407, 3110.0825256549374, 3113.2061324362144, 3140.544621029984, 927.7912469694264, 957.5355952363099, 979.5200351827554, 1021.9795604087876, 1136.6930928649383, 29092.709072909423, 29194.41611167765, 29297.414051718846, 29560.704392955795, 29745.553816692765, 944.15498129174, 1057.1965306367063, 1071.8820929697727, 1145.5360578965533, 1171.1509155862102, 15010.924945375204, 15564.844351556567, 15651.530454086396, 15656.373745050298, 15935.12356820386, 382194.0, 385079.0, 386900.0, 387181.0, 387510.0, 51145.23282150771, 51585.0, 51708.48291517112, 51766.0, 51790.0, 1184.9723955294135, 1308.784050631654, 1314.1392387985884, 1342.8187194728782, 1343.8656134386483, 27760.72239277662, 29476.705232947395, 29689.25776855596, 29794.70205297919, 30182.396352073276, 43567.56432435635, 43638.0, 44251.33622995593, 44298.778506107265, 44306.77846610746, 292904.0, 294914.0, 295164.0, 295206.0, 295232.0, 22913.65629515525, 24933.376665583506, 26006.34984125412, 26156.738432616192, 27323.31691707723, 43414.78292608643, 45126.54873451355, 46289.0, 47306.76346618245, 49843.25235121403, 38165.0, 38191.61808381881, 38575.6142438572, 38613.80693096516, 39027.41458878062, 37239.50392649857, 37472.625273748, 37602.0, 37976.62023379731, 38182.0, 36489.63510364862, 36557.45163822491, 36814.44778328274, 37168.25663486769, 37194.44208336823, 32482.35035299328, 34015.829920850236, 34085.31829363349, 34099.82950085333, 34165.829170853984, 25674.358141045876, 25700.0, 25937.0, 26022.73977260203, 26044.479110417305], "value": 17395.765186032055, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.3284669711262, 382.91001614620575, 391.8589307849174, 397.8289335585697, 403.60245158518853, 15754.606134846621, 17430.38993635223, 18098.0, 18134.727979080308, 18146.637067258664, 16370.427035053775, 16427.67144657109, 17006.744898826528, 17195.742063869053, 17589.64820703585, 5056.342675452195, 5173.793048278064, 5182.455842136578, 5183.766730497118, 5232.633715639907, 3590.461430785377, 4838.419389673227, 5915.112733090049, 5918.615290006136, 6035.245594300713, 5838.620489668158, 5923.970380148115, 5975.731092100844, 5986.0, 5995.430434108753, 5803.419658034205, 5909.379515150912, 5987.970060149715, 6016.458518733291, 6019.157317975487, 5171.534561889448, 5252.684838909678, 5255.369355677305, 5257.474252574751, 5261.263423120728, 20770.0, 20897.268595599235, 20906.37280881576, 20927.37217883466, 21303.25438609641, 1904.628597423503, 1912.1873203888292, 1936.6804477261235, 1962.5976674781637, 2056.7840376760523, 12874.098813083088, 13168.473261069546, 13209.141405808688, 13266.469341226339, 13737.862621373759, 1797.8381945624956, 1845.2342277954633, 1922.5674223299786, 1944.8346890514324, 1972.1618312217395, 68068.0, 68239.9999999995, 70036.0, 70610.0, 71968.0, 10167.949160254151, 10253.436061016566, 10451.84322235167, 10560.260781745357, 10614.0, 14395.352209150613, 14421.92789036069, 14505.274736263145, 14512.0, 14521.0, 7562.810929726801, 7774.183710710294, 7807.258310460497, 7902.209779022167, 7945.64244608994, 7507.21174276704, 7513.812154696177, 7524.623768811538, 7621.123570789319, 7632.0, 4495.842645507391, 4528.818847246139, 4552.2488789350045, 4555.612772914273, 4557.134144512532, 1889.9716504252447, 1921.9519512012312, 1926.489480287725, 1927.2194761121768, 1982.4350060232764, 857.7984173719171, 881.678187461572, 882.9690960816469, 903.5075883643431, 948.4309414351334, 16377.83622163787, 16522.50432487027, 17074.743878841826, 17661.11694415274, 19083.522911927314, 904.326276923696, 914.7804526913626, 929.874466946967, 933.8645896344992, 979.2313034268066, 9677.806443871083, 9750.26872984529, 10008.549615267184, 10008.849867251996, 10059.849102263472, 396645.0, 420516.0, 421373.0, 425330.0, 425764.0, 49813.0, 75530.62234688792, 76639.0, 77071.0, 90809.0, 444.4977175791335, 459.8896264896401, 461.23895572305963, 461.50157829543343, 462.5305315105171, 9726.173275271682, 9930.05664461875, 9973.451460169761, 10290.588376465157, 10735.248532602644, 33696.35615428351, 36975.26049479049, 37565.624343756215, 38117.23765524729, 38747.225055498166, 49721.25418118659, 52322.72127344743, 52516.212256815415, 53528.0, 54423.45576544184, 7600.80997975055, 7929.960350198212, 7939.880901786593, 7954.64204110828, 7959.920400795918, 8733.65065397377, 11330.490127944098, 11630.244034137753, 11687.415629218674, 12153.33156676356, 10156.89843101589, 10166.949165254126, 10414.583416663248, 10558.0, 10579.259451838298, 10061.295709300279, 10236.385816851012, 10327.225458090523, 10331.845022324822, 10366.844497332697, 10464.796548397031, 10682.83975740349, 10752.247342686249, 10863.891361086287, 10867.456627168767, 7744.225577442211, 7833.725819596515, 7835.098963619029, 7870.173631768582, 7974.561399122872, 10114.494275286354, 10467.581296748045, 10552.630657926935, 10669.35983840972, 10677.786444270916], "value": 8271.482126853882, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.7344531093784, 1387.8265216847894, 1492.0525466328882, 1651.983480165198, 1860.413969599576, 7433.256674332571, 7780.377569794417, 7825.41309401795, 7988.800279993003, 7988.9600551997155, 7744.26429489199, 7924.603769811501, 7945.046594408679, 7954.443188976774, 7965.880511792313, 2266.750657427686, 2289.748127705951, 2291.7822806833324, 2292.037344315383, 2293.587154312223, 2225.621644320461, 2258.8080013198814, 2285.988570057147, 2286.9542609147807, 2290.725112986444, 2209.3924170853065, 2212.3805334506283, 2229.6321107017325, 2232.229880691159, 2237.2057919438607, 2150.7956744109283, 2168.186929901287, 2182.9999999999923, 2183.7816218378193, 2185.5410363823617, 2177.096504950444, 2187.464071302541, 2187.8796666183352, 2188.2231807708195, 2189.0805861538192, 7558.659860306299, 7779.72770953014, 7783.182765809622, 7866.0560732711865, 7867.763967080997, 4792.424909010941, 4899.265110233458, 4899.8040078396825, 4900.509949005107, 4907.681000734977, 2861.1988643179943, 2867.569864520318, 2925.3564215872475, 3012.2770535071427, 3019.728224459809, 911.2345629671108, 923.3398120343986, 927.2628260532892, 937.5968333616543, 943.556528431636, 10592.523336449878, 10681.35911845284, 10683.679489615324, 10684.946575267151, 10699.572017119306, 4136.131412403369, 4237.576242375738, 4281.443412356436, 4291.420658211164, 4314.89212769677, 8528.232459078712, 8559.529225892511, 8564.700235491853, 8566.78583035429, 8573.442726222776, 4626.467956185014, 4740.6681532292405, 4743.430788305425, 4743.644226683013, 4744.335792988984, 3617.4573813928123, 4104.958950410517, 4212.789360531961, 4216.515100763451, 4409.581089796464, 3427.657234276602, 3433.9828300858335, 3531.6998055165086, 3531.8763843265874, 3553.3248682750195, 1029.5933106422922, 1030.3817709374316, 1035.9067683908484, 1041.942693151884, 1042.1714736784274, 634.5494698763929, 722.2741145149091, 728.4754976416971, 794.9006374203225, 862.6894318045498, 4882.145624515767, 5092.0, 5165.66423182492, 5190.480951904779, 5268.552173065255, 470.240561493186, 471.8957639124465, 479.302614695617, 490.65899200056333, 620.8913440148046, 3327.101682545699, 3347.4978753187215, 3362.9663703362653, 3386.52588637586, 3405.8637654494037, 8629.309655227567, 9032.283846088556, 9047.366684332164, 9088.409253398508, 9147.2682185425, 8962.596683149273, 8994.550272486349, 9036.593353299117, 9054.0, 9085.591148398338, 6986.755463558751, 7110.466714996396, 7160.82097947545, 7161.355478007004, 7187.137543494814, 4954.355933728592, 4983.152864013199, 5009.198528235464, 5096.210087436453, 5199.63602547818, 8336.624851881801, 8425.115362886809, 8447.197516235949, 8505.574721263789, 8588.570571471526, 8315.625796839036, 8521.105283945097, 8550.57247137653, 8550.957245213734, 8591.355648326275, 5748.425157484218, 5772.076467765138, 5795.710214489174, 5795.971020144872, 5822.883542329215, 6879.484038697017, 6926.030355750299, 6957.2694867038235, 6958.338957799001, 6962.651867406711, 5710.857228569319, 5957.821265362046, 6555.508336874849, 6649.368310010541, 6888.41448476865, 6645.700943457459, 6776.7628133015105, 6819.0, 6863.142107236596, 6903.378695917391, 6427.0680751289865, 6486.935130648633, 6496.415322620798, 6497.02544618311, 6503.577267477788, 4353.4122893408985, 4436.0462500562535, 4470.418845550058, 4495.685302028826, 4601.688518772134, 4552.226121559409, 4557.931631025471, 4592.0815836833435, 4681.929771053369, 4703.858884233478], "value": 3999.8754308285324, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.61982381494573, 313.0764245475847, 317.9523071539267, 319.29913839123134, 323.56480533682196, 4792.424909010919, 4829.22732362822, 4836.129496690594, 4838.419389673244, 4848.975755121228, 4757.833475828338, 4765.785539650716, 4782.6173906087515, 4783.168999310704, 4789.305550695147, 3589.9641003590023, 3700.3894357431127, 3753.6434038766274, 3843.48113004745, 3872.7095467839886, 3776.188119554295, 3777.8299976501125, 3822.44574536692, 3827.7320587558884, 3858.3633700439395, 3535.1515636247373, 3773.5094437723055, 3774.641409066148, 3775.509183806101, 3796.753211041287, 3660.304542136999, 3743.2513497300647, 3751.81240937952, 3771.0, 3781.9032480580736, 3308.8511017004053, 3310.5034244863223, 3329.0845017620104, 3337.599488061424, 3341.031100980713, 4549.363089167519, 4578.175928332898, 4609.354690343354, 4622.422197225347, 4624.421947256593, 4180.7909604519655, 4251.634581797956, 4330.765731766432, 4338.891527711801, 4344.978275108636, 4991.176455884774, 5006.823396501855, 5020.920502092068, 5038.312165424587, 5045.949540504585, 3678.521792167028, 3682.871099511531, 3685.0603096210293, 3689.1699367642336, 3694.224212915291, 4946.950530494685, 5162.483751624807, 5182.0, 5301.496357845998, 5302.269331294387, 3701.3337599232395, 3706.814659267026, 3709.3323201823932, 3719.683826874692, 3745.1198968242443, 3790.56408513019, 3792.5259342582176, 3798.24035192957, 3799.316123097869, 3803.8858834234466, 4279.957200427956, 4307.6338511226895, 4315.158544083936, 4318.963448772272, 4325.351197320427, 4760.809567617326, 4983.950160498421, 4997.425296090996, 5011.874703132378, 5077.568406685399, 1309.9083064185415, 1322.3388305847077, 1325.3704490367, 1327.2368388176837, 1327.5993826513122, 843.5487014447241, 870.3994243971639, 914.6204325205099, 920.9907900921039, 927.5501381829807, 4323.416338794285, 4400.889977750582, 4419.624331931757, 4430.911381772346, 4431.578999994996, 5097.719625420564, 5110.872228194325, 5111.693298402108, 5123.154679477844, 5150.150225212873, 4214.936775948363, 4375.584319489643, 4385.122975404868, 4399.1641588098155, 4406.911861762746, 2685.1407549584337, 2699.25770413138, 2703.810733248693, 2723.978508059478, 2735.0, 4772.7136371817805, 4782.497837727058, 4782.689125206851, 4783.182390691515, 4801.327814106028, 4973.825916092992, 5148.459411761711, 5178.81874134411, 5195.272661827347, 5261.263423120766, 4871.610271178297, 4875.780589873464, 4880.316290879641, 4884.462709102067, 4896.2410826321975, 5197.194434862602, 5200.297959775382, 5206.739663016759, 5206.97396513015, 5213.452587478412, 4924.679895806761, 5078.238264260242, 5125.282460455614, 5146.974265128651, 5165.354330708661, 4843.07981483517, 4871.48849370811, 4880.755962201947, 4882.340883980617, 4887.657863949489, 3683.557973043252, 3695.427208782643, 3704.24063067076, 3708.6291370862696, 3725.7950812705562, 4929.704217746947, 5159.406668233201, 5193.584513238856, 5212.758513839086, 5228.0, 4970.975145124251, 4985.9501404985485, 4996.200607902718, 4996.750162491933, 5004.974975125101, 5008.298838162733, 5015.498450154955, 5028.0, 5034.773435195499, 5053.216751403538, 4791.113643975876, 4941.481144479922, 4941.851744447672, 4994.825181118644, 5019.3976722793495, 4818.4217893852965, 4963.8262660806695, 5051.898962020812, 5076.289319495348, 5076.796928122833, 4909.1899836528, 4934.358533390637, 4955.479674634112, 5007.424146223086, 5020.397552293748], "value": 3807.042120118822, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.4746677325872, 807.045826554379, 812.695239285268, 815.3029160068141, 819.5287709567001, 12637.494500219991, 12904.483820647187, 12930.547430839923, 12946.935265323673, 12961.740765184692, 12276.815847762291, 12279.324637144953, 12284.508619655226, 12313.261204327724, 12314.630561083159, 673.7473447457204, 840.4873027453249, 852.9701460448902, 863.3309185381348, 871.4727589808169, 848.406115718996, 852.6845067325067, 854.3378881366929, 855.5209082913589, 856.8157846063095, 595.1132812109946, 597.0596310810491, 597.3638075449654, 598.6378241164099, 598.8443004818735, 683.6855046678534, 890.6971629645919, 911.1571796088658, 913.9451632902047, 916.706653870755, 676.668432468092, 676.6853413162903, 677.3734295776387, 677.6273049822627, 677.857649893523, 12809.935950320189, 12866.163699359511, 12873.485060597564, 12901.419436125398, 12941.417636206394, 11776.705582360424, 11959.641210763692, 11993.0, 12047.819282710767, 12055.638330850088, 10613.363198208132, 10760.461976901124, 10793.08258798003, 11051.778964420748, 11089.778204435866, 4169.958300417018, 4171.7496950182785, 4194.559571245006, 4232.470941132358, 4276.807543660511, 39733.60266397328, 41246.587534124876, 41949.370759438636, 41989.37015944763, 42378.0, 9246.907530924605, 9351.625934962662, 9449.858252126223, 9471.0, 9871.654492092743, 17003.31986720542, 17066.829331706773, 17132.486025419257, 17208.741868871977, 17274.827251727573, 6232.56372053961, 6400.359964003563, 6411.903821442682, 6449.774257900951, 6581.407673309425, 3656.7988760618423, 3688.4098544232793, 3690.7970061646865, 3775.075106598846, 3798.3352913240074, 2717.9943420934383, 2792.357757715696, 2795.6645202575414, 2798.2864369585627, 2799.664040315175, 417.4760675352413, 495.47974626642605, 512.9230615407719, 512.9717865517358, 533.842516457646, 446.92626214364725, 523.7459831981486, 542.9809956651499, 550.4165584480463, 553.5599198637093, 7376.7418140364825, 7512.962435187898, 7646.732364367221, 7788.065432148179, 7862.488938218998, 517.8575891629832, 549.3572520151353, 615.4245780195531, 627.2629660149397, 628.8710814283061, 3800.1829606634155, 3920.313945059603, 3950.367941129463, 4014.1770936957855, 4054.3310353791885, 54004.45995539994, 56202.71898640563, 56895.43104568984, 56981.43018569844, 57124.71437642868, 39868.800655996536, 42337.364939525934, 42598.78700606477, 46003.30995035077, 50163.24755128676, 41816.790916045225, 43339.0, 43413.78293108577, 43608.78195609065, 44329.335059974124, 7022.40309573692, 8219.424640275363, 8397.70608028716, 8440.662373505236, 8565.700200492953, 28544.286392840346, 28768.856155719088, 30023.249418763833, 30135.547966780956, 30175.698243018167, 38271.42592861165, 38838.6116138835, 38846.41730374103, 38893.416598750475, 38914.83255502339, 9301.534923253676, 9375.24998000172, 9387.342885997914, 9400.34197606161, 9401.200897923753, 9706.951465242912, 10076.3282862187, 10177.287589868638, 10256.743581410525, 10675.57297708083, 9665.71002869915, 9668.75828104303, 9713.465759383302, 9969.152622027208, 9979.50102494887, 9684.70945871625, 9854.901450985399, 9895.455749933823, 9964.800703985735, 10147.49262536885, 9640.228781697308, 9753.853692194765, 9913.0, 10049.995000499892, 10248.692539223835, 8394.118617545315, 8414.326853851555, 8424.368172387218, 8681.565921704016, 8746.562671866253, 8601.618126181926, 8642.654293828176, 8683.522406267715, 8813.603387847434, 8852.513111778913], "value": 5802.980120988165, "unit": "score"}], "name": "dromaeo_css", "value": 6243.860497407187, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 112.0, 113.0, 114.0, 113.0, 112.0, 115.0, 115.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 134.0, 159.0, 227.0, 133.0, 162.0, 153.0, 138.0, 181.0, 140.0], "value": 158.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 161.0, 160.0, 160.0, 162.0, 161.0, 158.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 163.0, 77.0, 78.0, 77.0, 77.0, 130.0, 75.0], "value": 91.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 154.0, 93.0, 92.0, 93.0, 128.0, 93.0, 93.0, 126.0], "value": 106.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 119.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 120.0, 65.0, 65.0], "value": 72.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 65.0, 65.0, 63.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 83.0, 83.0, 83.0, 83.0, 88.0, 85.0, 87.0, 89.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 133.0, 133.0, 138.0, 129.0, 139.0, 130.0, 133.0, 256.0, 138.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 175.0, 176.0, 175.0, 175.0, 176.0, 172.0, 179.0, 173.0, 178.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 69.0, 70.0, 69.0, 66.0, 67.0, 66.0, 66.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1600.8, "alertThreshold": 2.0}]} 05:18:37 INFO - Return code: 0 05:18:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:18:37 ERROR - # TBPL SUCCESS # 05:18:37 INFO - Running post-action listener: _resource_record_post_action 05:18:37 INFO - ##### 05:18:37 INFO - ##### Finished run-tests step (success) 05:18:37 INFO - ##### 05:18:37 INFO - Running post-run listener: _resource_record_post_run 05:18:38 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 531099648; Read time: 244; Write time: 682592 05:18:38 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 233840640; Read time: 0; Write time: 384220 05:18:38 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 296161280; Read time: 244; Write time: 298072 05:18:38 INFO - Running post-run listener: _upload_blobber_files 05:18:38 INFO - Blob upload gear active. 05:18:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:18:38 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 05:18:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:18:39 INFO - (blobuploader) - INFO - Open directory for files ... 05:18:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:18:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:18:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:40 INFO - (blobuploader) - INFO - Done attempting. 05:18:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:18:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:18:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:40 INFO - (blobuploader) - INFO - Done attempting. 05:18:40 INFO - (blobuploader) - INFO - Iteration through files over. 05:18:40 INFO - Return code: 0 05:18:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:18:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:18:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2de35bd38727ea5749abd77ae7cc0551454dbb6ccf96f65be6b2eabaa98f990c74cae7ca595db02b504e6d2084312495e6a615fcdd9a681e07f12e754759118", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d0397e06c9df97c6ab2684d1b91a797ecd25ecff5e0e42f86c9e38e7c5fadb90c59864c776ae6d4384349d7bc5130673b7b2b5a7c415d7d22247168a30c0550"} 05:18:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:18:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:18:40 INFO - Contents: 05:18:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2de35bd38727ea5749abd77ae7cc0551454dbb6ccf96f65be6b2eabaa98f990c74cae7ca595db02b504e6d2084312495e6a615fcdd9a681e07f12e754759118", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d0397e06c9df97c6ab2684d1b91a797ecd25ecff5e0e42f86c9e38e7c5fadb90c59864c776ae6d4384349d7bc5130673b7b2b5a7c415d7d22247168a30c0550"} 05:18:40 INFO - Running post-run listener: copy_logs_to_upload_dir 05:18:40 INFO - Copying logs to upload dir... 05:18:40 INFO - mkdir: /builds/slave/test/build/upload/logs 05:18:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.567939 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-10 05:18:40.051829) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 05:18:40.055455) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2de35bd38727ea5749abd77ae7cc0551454dbb6ccf96f65be6b2eabaa98f990c74cae7ca595db02b504e6d2084312495e6a615fcdd9a681e07f12e754759118", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d0397e06c9df97c6ab2684d1b91a797ecd25ecff5e0e42f86c9e38e7c5fadb90c59864c776ae6d4384349d7bc5130673b7b2b5a7c415d7d22247168a30c0550"} build_url:https://queue.taskcluster.net/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011151 build_url: 'https://queue.taskcluster.net/v1/task/K2CToNDwTTutH_93JVw51g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2de35bd38727ea5749abd77ae7cc0551454dbb6ccf96f65be6b2eabaa98f990c74cae7ca595db02b504e6d2084312495e6a615fcdd9a681e07f12e754759118", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d0397e06c9df97c6ab2684d1b91a797ecd25ecff5e0e42f86c9e38e7c5fadb90c59864c776ae6d4384349d7bc5130673b7b2b5a7c415d7d22247168a30c0550"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 05:18:40.084549) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:18:40.084890) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1462881477.818364-1351191471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:18:40.170042) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 05:18:40.170370) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 05:18:40.170695) ========= ========= Total master_lag: 0.18 =========