builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1461844292.88 results: success (0) buildid: 20160428034800 builduid: 2dfa8c73ae054518a25c5747e5d459c4 revision: 830f7765555a3740103c31100118bf318cf785b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:32.884827) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:32.885490) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:32.885916) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:32.915408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:32.915712) ========= 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=d2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 04:51:32-- 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% 211M=0s 2016-04-28 04:51:32 (211 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077486 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:33.006189) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:33.006494) ========= 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=d2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022557 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:33.056933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:33.057306) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 830f7765555a3740103c31100118bf318cf785b2 --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 830f7765555a3740103c31100118bf318cf785b2 --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=d2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 04:51:33,083 truncating revision to first 12 chars 2016-04-28 04:51:33,083 Setting DEBUG logging. 2016-04-28 04:51:33,083 attempt 1/10 2016-04-28 04:51:33,083 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/830f7765555a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 04:51:33,344 unpacking tar archive at: fx-team-830f7765555a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.551152 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:33.620417) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:33.620776) ========= script_repo_revision: 830f7765555a3740103c31100118bf318cf785b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:33.621179) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:33.621441) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 04:51:33.629379) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-28 04:51:33.629749) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:51:33 INFO - MultiFileLogger online at 20160428 04:51:33 in /builds/slave/test 04:51:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:51:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:51:33 INFO - {'append_to_log': False, 04:51:33 INFO - 'base_work_dir': '/builds/slave/test', 04:51:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:51:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:51:33 INFO - 'branch': 'Fx-Team-Non-PGO', 04:51:33 INFO - 'buildbot_json_path': 'buildprops.json', 04:51:33 INFO - 'config_files': ('talos/linux_config.py',), 04:51:33 INFO - 'default_actions': ('clobber', 04:51:33 INFO - 'read-buildbot-config', 04:51:33 INFO - 'download-and-extract', 04:51:33 INFO - 'populate-webroot', 04:51:33 INFO - 'create-virtualenv', 04:51:33 INFO - 'install', 04:51:33 INFO - 'run-tests'), 04:51:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:51:33 INFO - 'download_minidump_stackwalk': True, 04:51:33 INFO - 'download_symbols': 'ondemand', 04:51:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:51:33 INFO - 'tooltool.py': '/tools/tooltool.py', 04:51:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:51:33 INFO - '/tools/misc-python/virtualenv.py')}, 04:51:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:51:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:51:33 INFO - 'installer_path': 'installer.exe', 04:51:33 INFO - 'log_level': 'info', 04:51:33 INFO - 'log_name': 'talos', 04:51:33 INFO - 'log_to_console': True, 04:51:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:51:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:51:33 INFO - 'opt_config_files': (), 04:51:33 INFO - 'pip_index': False, 04:51:33 INFO - 'sps_profile': False, 04:51:33 INFO - 'sps_profile_interval': 0, 04:51:33 INFO - 'suite': 'dromaeojs-e10s', 04:51:33 INFO - 'system_bits': '32', 04:51:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:51:33 INFO - 'title': 'talos-linux64-ix-043', 04:51:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:51:33 INFO - 'use_talos_json': True, 04:51:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:51:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:51:33 INFO - 'work_dir': 'build'} 04:51:33 INFO - ##### 04:51:33 INFO - ##### Running clobber step. 04:51:33 INFO - ##### 04:51:33 INFO - Running pre-action listener: _resource_record_pre_action 04:51:33 INFO - Running main action method: clobber 04:51:33 INFO - rmtree: /builds/slave/test/build 04:51:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:51:34 INFO - Running post-action listener: _resource_record_post_action 04:51:34 INFO - ##### 04:51:34 INFO - ##### Running read-buildbot-config step. 04:51:34 INFO - ##### 04:51:34 INFO - Running pre-action listener: _resource_record_pre_action 04:51:34 INFO - Running main action method: read_buildbot_config 04:51:34 INFO - Using buildbot properties: 04:51:34 INFO - { 04:51:34 INFO - "project": "", 04:51:34 INFO - "product": "firefox", 04:51:34 INFO - "script_repo_revision": "production", 04:51:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:51:34 INFO - "repository": "", 04:51:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:51:34 INFO - "buildid": "20160428034800", 04:51:34 INFO - "pgo_build": "False", 04:51:34 INFO - "basedir": "/builds/slave/test", 04:51:34 INFO - "buildnumber": 1231, 04:51:34 INFO - "slavename": "talos-linux64-ix-043", 04:51:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:51:34 INFO - "platform": "ubuntu64_hw", 04:51:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:51:34 INFO - "branch": "fx-team", 04:51:34 INFO - "repo_path": "integration/fx-team", 04:51:34 INFO - "revision": "830f7765555a3740103c31100118bf318cf785b2", 04:51:34 INFO - "stage_platform": "linux64", 04:51:34 INFO - "builduid": "2dfa8c73ae054518a25c5747e5d459c4", 04:51:34 INFO - "slavebuilddir": "test" 04:51:34 INFO - } 04:51:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:51:34 INFO - Running post-action listener: _resource_record_post_action 04:51:34 INFO - ##### 04:51:34 INFO - ##### Running download-and-extract step. 04:51:34 INFO - ##### 04:51:34 INFO - Running pre-action listener: _resource_record_pre_action 04:51:34 INFO - Running main action method: download_and_extract 04:51:34 INFO - mkdir: /builds/slave/test/build/tests 04:51:34 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:51:34 INFO - https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:51:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:51:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:51:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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:51:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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:51:40 INFO - Downloaded 1361 bytes. 04:51:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:51:40 INFO - Using the following test package requirements: 04:51:40 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:51:40 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:51:40 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:51:40 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:40 INFO - u'jsshell-linux-x86_64.zip'], 04:51:40 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:51:40 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:51:40 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:51:40 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:51:40 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:51:40 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:51:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:51:40 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:51:40 INFO - https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:51:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:51:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:51:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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:51:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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:51:42 INFO - Downloaded 22293278 bytes. 04:51:42 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:51:42 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:51:43 INFO - Return code: 0 04:51:43 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:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:43 INFO - https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:51:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:51:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:51:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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:51:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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:51:44 INFO - Downloaded 22293278 bytes. 04:51:44 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:51:44 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:51:46 INFO - Return code: 0 04:51:46 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:51:46 INFO - https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:51:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:51:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:51:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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:51:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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:51:49 INFO - Downloaded 10840145 bytes. 04:51:49 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:51:49 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:51:49 INFO - Return code: 0 04:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:49 INFO - https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:51:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:51:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:51:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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:51:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BIdHtpy0SiSl-juUHy_BfQ/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:51:51 INFO - Downloaded 54839520 bytes. 04:51:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:51:51 INFO - mkdir: /builds/slave/test/properties 04:51:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:51:51 INFO - Writing to file /builds/slave/test/properties/build_url 04:51:51 INFO - Contents: 04:51:51 INFO - build_url:https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:51:52 INFO - Running post-action listener: _resource_record_post_action 04:51:52 INFO - Running post-action listener: set_extra_try_arguments 04:51:52 INFO - ##### 04:51:52 INFO - ##### Running populate-webroot step. 04:51:52 INFO - ##### 04:51:52 INFO - Running pre-action listener: _resource_record_pre_action 04:51:52 INFO - Running main action method: populate_webroot 04:51:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:51:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:51:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:51:52 INFO - '--tppagecycles', 04:51:52 INFO - '7'], 04:51:52 INFO - 'tests': ['tsvgm']}}, 04:51:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:51:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:51:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:51:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:51:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:51:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:51:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:52 INFO - 'talos_options': ['--disable-e10s'], 04:51:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:51:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:51:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:52 INFO - 'talos_options': ['--disable-e10s'], 04:51:52 INFO - 'tests': ['damp', 'tps']}, 04:51:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:52 INFO - 'tests': ['damp', 'tps']}, 04:51:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:51:52 INFO - 'tests': ['dromaeo_dom']}, 04:51:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:51:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:51:52 INFO - 'tests': ['a11yr', 04:51:52 INFO - 'ts_paint', 04:51:52 INFO - 'tpaint', 04:51:52 INFO - 'sessionrestore', 04:51:52 INFO - 'sessionrestore_no_auto_restore', 04:51:52 INFO - 'tabpaint']}, 04:51:52 INFO - 'other-e10s': {'tests': ['a11yr', 04:51:52 INFO - 'ts_paint', 04:51:52 INFO - 'tpaint', 04:51:52 INFO - 'sessionrestore', 04:51:52 INFO - 'sessionrestore_no_auto_restore', 04:51:52 INFO - 'tabpaint']}, 04:51:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:51:52 INFO - 'ts_paint', 04:51:52 INFO - 'tpaint', 04:51:52 INFO - 'sessionrestore', 04:51:52 INFO - 'sessionrestore_no_auto_restore', 04:51:52 INFO - 'tabpaint']}, 04:51:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:51:52 INFO - 'ts_paint', 04:51:52 INFO - 'tpaint', 04:51:52 INFO - 'sessionrestore', 04:51:52 INFO - 'sessionrestore_no_auto_restore', 04:51:52 INFO - 'tabpaint']}, 04:51:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:51:52 INFO - 'tests': ['a11yr', 04:51:52 INFO - 'ts_paint', 04:51:52 INFO - 'tpaint', 04:51:52 INFO - 'sessionrestore', 04:51:52 INFO - 'sessionrestore_no_auto_restore', 04:51:52 INFO - 'tabpaint']}, 04:51:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:51:52 INFO - 'tests': ['a11yr', 04:51:52 INFO - 'ts_paint', 04:51:52 INFO - 'tpaint', 04:51:52 INFO - 'sessionrestore', 04:51:52 INFO - 'sessionrestore_no_auto_restore', 04:51:52 INFO - 'tabpaint']}, 04:51:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:51:52 INFO - 'tests': ['tsvgx', 04:51:52 INFO - 'tsvgr_opacity', 04:51:52 INFO - 'tart', 04:51:52 INFO - 'tscrollx', 04:51:52 INFO - 'cart']}, 04:51:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:51:52 INFO - 'tsvgr_opacity', 04:51:52 INFO - 'tart', 04:51:52 INFO - 'tscrollx', 04:51:52 INFO - 'cart']}, 04:51:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:52 INFO - 'talos_options': ['--disable-e10s'], 04:51:52 INFO - 'tests': ['tp5o']}, 04:51:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:52 INFO - 'tests': ['tp5o']}, 04:51:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:52 INFO - 'talos_options': ['--disable-e10s', 04:51:52 INFO - '--xperf_path', 04:51:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:51:52 INFO - 'tests': ['tp5n']}, 04:51:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:52 INFO - 'talos_options': ['--xperf_path', 04:51:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:51:52 INFO - 'tests': ['tp5n']}}, 04:51:52 INFO - 'talos.zip': {'path': '', 04:51:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:51:52 INFO - Running post-action listener: _resource_record_post_action 04:51:52 INFO - ##### 04:51:52 INFO - ##### Running create-virtualenv step. 04:51:52 INFO - ##### 04:51:52 INFO - Running pre-action listener: _resource_record_pre_action 04:51:52 INFO - Running main action method: create_virtualenv 04:51:52 INFO - Creating virtualenv /builds/slave/test/build/venv 04:51:52 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:51:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:51:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:51:52 INFO - Using real prefix '/usr' 04:51:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:51:53 INFO - Installing distribute.............................................................................................................................................................................................done. 04:51:55 INFO - Installing pip.................done. 04:51:55 INFO - Return code: 0 04:51:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:51:55 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:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:55 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:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:55 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 0x7f4e583a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12410>, '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 0xe13310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe137a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', '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:51:55 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:51:55 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:51:55 INFO - Using env: {'DISPLAY': ':0', 04:51:55 INFO - 'HOME': '/home/cltbld', 04:51:55 INFO - 'LANG': 'en_US.UTF-8', 04:51:55 INFO - 'LANGUAGE': 'en_US:en', 04:51:55 INFO - 'LOGNAME': 'cltbld', 04:51:55 INFO - 'MAIL': '/var/mail/cltbld', 04:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:55 INFO - 'MOZ_NO_REMOTE': '1', 04:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:55 INFO - 'NO_EM_RESTART': '1', 04:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:55 INFO - 'PWD': '/builds/slave/test', 04:51:55 INFO - 'SHELL': '/bin/bash', 04:51:55 INFO - 'SHLVL': '1', 04:51:55 INFO - 'TERM': 'linux', 04:51:55 INFO - 'TMOUT': '86400', 04:51:55 INFO - 'USER': 'cltbld', 04:51:55 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', 04:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:55 INFO - '_': '/tools/buildbot/bin/python'} 04:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:55 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:51:55 INFO - Cleaning up... 04:51:55 INFO - Return code: 0 04:51:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:51:55 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:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:55 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:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:55 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 0x7f4e583a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12410>, '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 0xe13310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe137a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', '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:51:55 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:51:55 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:51:55 INFO - Using env: {'DISPLAY': ':0', 04:51:55 INFO - 'HOME': '/home/cltbld', 04:51:55 INFO - 'LANG': 'en_US.UTF-8', 04:51:55 INFO - 'LANGUAGE': 'en_US:en', 04:51:55 INFO - 'LOGNAME': 'cltbld', 04:51:55 INFO - 'MAIL': '/var/mail/cltbld', 04:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:55 INFO - 'MOZ_NO_REMOTE': '1', 04:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:55 INFO - 'NO_EM_RESTART': '1', 04:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:55 INFO - 'PWD': '/builds/slave/test', 04:51:55 INFO - 'SHELL': '/bin/bash', 04:51:55 INFO - 'SHLVL': '1', 04:51:55 INFO - 'TERM': 'linux', 04:51:55 INFO - 'TMOUT': '86400', 04:51:55 INFO - 'USER': 'cltbld', 04:51:55 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', 04:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:55 INFO - '_': '/tools/buildbot/bin/python'} 04:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:55 INFO - Downloading/unpacking psutil>=0.7.1 04:51:55 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:51:55 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:51:55 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:51:55 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:51:55 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:51:55 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:51:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:51:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:51:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:51:57 INFO - Installing collected packages: psutil 04:51:57 INFO - Running setup.py install for psutil 04:51:57 INFO - building 'psutil._psutil_linux' extension 04:51:57 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:51:57 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:51:57 INFO - building 'psutil._psutil_posix' extension 04:51:57 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:51:58 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:51:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:51:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:51:58 INFO - Successfully installed psutil 04:51:58 INFO - Cleaning up... 04:51:58 INFO - Return code: 0 04:51:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:51:58 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:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:58 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:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:58 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 0x7f4e583a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12410>, '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 0xe13310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe137a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', '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:51:58 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:51:58 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:51:58 INFO - Using env: {'DISPLAY': ':0', 04:51:58 INFO - 'HOME': '/home/cltbld', 04:51:58 INFO - 'LANG': 'en_US.UTF-8', 04:51:58 INFO - 'LANGUAGE': 'en_US:en', 04:51:58 INFO - 'LOGNAME': 'cltbld', 04:51:58 INFO - 'MAIL': '/var/mail/cltbld', 04:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:58 INFO - 'MOZ_NO_REMOTE': '1', 04:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:58 INFO - 'NO_EM_RESTART': '1', 04:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:58 INFO - 'PWD': '/builds/slave/test', 04:51:58 INFO - 'SHELL': '/bin/bash', 04:51:58 INFO - 'SHLVL': '1', 04:51:58 INFO - 'TERM': 'linux', 04:51:58 INFO - 'TMOUT': '86400', 04:51:58 INFO - 'USER': 'cltbld', 04:51:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', 04:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:58 INFO - '_': '/tools/buildbot/bin/python'} 04:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:51:58 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:51:58 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:51:58 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:51:58 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:51:58 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:51:58 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:52:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:52:00 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:52:00 INFO - Installing collected packages: mozsystemmonitor 04:52:00 INFO - Running setup.py install for mozsystemmonitor 04:52:00 INFO - Successfully installed mozsystemmonitor 04:52:00 INFO - Cleaning up... 04:52:00 INFO - Return code: 0 04:52:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:52: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:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:00 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 0x7f4e583a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12410>, '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 0xe13310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe137a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', '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:52:00 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:52:00 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:52:00 INFO - Using env: {'DISPLAY': ':0', 04:52:00 INFO - 'HOME': '/home/cltbld', 04:52:00 INFO - 'LANG': 'en_US.UTF-8', 04:52:00 INFO - 'LANGUAGE': 'en_US:en', 04:52:00 INFO - 'LOGNAME': 'cltbld', 04:52:00 INFO - 'MAIL': '/var/mail/cltbld', 04:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:00 INFO - 'MOZ_NO_REMOTE': '1', 04:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:00 INFO - 'NO_EM_RESTART': '1', 04:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:00 INFO - 'PWD': '/builds/slave/test', 04:52:00 INFO - 'SHELL': '/bin/bash', 04:52:00 INFO - 'SHLVL': '1', 04:52:00 INFO - 'TERM': 'linux', 04:52:00 INFO - 'TMOUT': '86400', 04:52:00 INFO - 'USER': 'cltbld', 04:52:00 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', 04:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:00 INFO - '_': '/tools/buildbot/bin/python'} 04:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:00 INFO - Downloading/unpacking blobuploader==1.2.4 04:52:00 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:52:00 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:52:00 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:52:00 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:52:00 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:52:00 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:52:02 INFO - Downloading blobuploader-1.2.4.tar.gz 04:52:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:52:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:52:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:03 INFO - Downloading docopt-0.6.1.tar.gz 04:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:52:03 INFO - Installing collected packages: blobuploader, requests, docopt 04:52:03 INFO - Running setup.py install for blobuploader 04:52:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:52:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:52:03 INFO - Running setup.py install for requests 04:52:03 INFO - Running setup.py install for docopt 04:52:03 INFO - Successfully installed blobuploader requests docopt 04:52:03 INFO - Cleaning up... 04:52:04 INFO - Return code: 0 04:52:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:04 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 0x7f4e583a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12410>, '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 0xe13310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe137a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', '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:52:04 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:52:04 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:52:04 INFO - Using env: {'DISPLAY': ':0', 04:52:04 INFO - 'HOME': '/home/cltbld', 04:52:04 INFO - 'LANG': 'en_US.UTF-8', 04:52:04 INFO - 'LANGUAGE': 'en_US:en', 04:52:04 INFO - 'LOGNAME': 'cltbld', 04:52:04 INFO - 'MAIL': '/var/mail/cltbld', 04:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:04 INFO - 'MOZ_NO_REMOTE': '1', 04:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:04 INFO - 'NO_EM_RESTART': '1', 04:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:04 INFO - 'PWD': '/builds/slave/test', 04:52:04 INFO - 'SHELL': '/bin/bash', 04:52:04 INFO - 'SHLVL': '1', 04:52:04 INFO - 'TERM': 'linux', 04:52:04 INFO - 'TMOUT': '86400', 04:52:04 INFO - 'USER': 'cltbld', 04:52:04 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', 04:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:04 INFO - '_': '/tools/buildbot/bin/python'} 04:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:04 INFO - Running setup.py (path:/tmp/pip-GnbekN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:04 INFO - Running setup.py (path:/tmp/pip-KDBNYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:04 INFO - Running setup.py (path:/tmp/pip-JPpqXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:04 INFO - Running setup.py (path:/tmp/pip-rZJr9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:04 INFO - Running setup.py (path:/tmp/pip-rCUaJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:04 INFO - Running setup.py (path:/tmp/pip-K1719j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:04 INFO - Running setup.py (path:/tmp/pip-raLDE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:04 INFO - Running setup.py (path:/tmp/pip-c0bgdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:04 INFO - Running setup.py (path:/tmp/pip-gSz1TD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:04 INFO - Running setup.py (path:/tmp/pip-pL2Jge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:04 INFO - Running setup.py (path:/tmp/pip-Abh0y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:05 INFO - Running setup.py (path:/tmp/pip-g7WZP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:05 INFO - Running setup.py (path:/tmp/pip-W79FYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:05 INFO - Running setup.py (path:/tmp/pip-hDpWc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:05 INFO - Running setup.py (path:/tmp/pip-CmB8uO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:05 INFO - Running setup.py (path:/tmp/pip-OPhazs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:05 INFO - Running setup.py (path:/tmp/pip-cdAHPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:52:05 INFO - Running setup.py install for manifestparser 04:52:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:52:05 INFO - Running setup.py install for mozcrash 04:52:05 INFO - Running setup.py install for mozdebug 04:52:05 INFO - Running setup.py install for mozdevice 04:52:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:52:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:52:05 INFO - Running setup.py install for mozfile 04:52:05 INFO - Running setup.py install for mozhttpd 04:52:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:52:06 INFO - Running setup.py install for mozinfo 04:52:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:52:06 INFO - Running setup.py install for mozInstall 04:52:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:52:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:52:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:52:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:52:06 INFO - Running setup.py install for mozleak 04:52:06 INFO - Running setup.py install for mozlog 04:52:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:52:06 INFO - Running setup.py install for moznetwork 04:52:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:52:06 INFO - Running setup.py install for mozprocess 04:52:06 INFO - Running setup.py install for mozprofile 04:52:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:52:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:52:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:52:06 INFO - Running setup.py install for mozrunner 04:52:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:52:06 INFO - Running setup.py install for mozscreenshot 04:52:07 INFO - Running setup.py install for moztest 04:52:07 INFO - Running setup.py install for mozversion 04:52:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:52:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:52:07 INFO - Cleaning up... 04:52:07 INFO - Return code: 0 04:52:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52: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:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:07 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 0x7f4e583a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12410>, '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 0xe13310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe137a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', '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:52:07 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:52:07 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:52:07 INFO - Using env: {'DISPLAY': ':0', 04:52:07 INFO - 'HOME': '/home/cltbld', 04:52:07 INFO - 'LANG': 'en_US.UTF-8', 04:52:07 INFO - 'LANGUAGE': 'en_US:en', 04:52:07 INFO - 'LOGNAME': 'cltbld', 04:52:07 INFO - 'MAIL': '/var/mail/cltbld', 04:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:07 INFO - 'MOZ_NO_REMOTE': '1', 04:52:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:07 INFO - 'NO_EM_RESTART': '1', 04:52:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:07 INFO - 'PWD': '/builds/slave/test', 04:52:07 INFO - 'SHELL': '/bin/bash', 04:52:07 INFO - 'SHLVL': '1', 04:52:07 INFO - 'TERM': 'linux', 04:52:07 INFO - 'TMOUT': '86400', 04:52:07 INFO - 'USER': 'cltbld', 04:52:07 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', 04:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:07 INFO - '_': '/tools/buildbot/bin/python'} 04:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:07 INFO - Running setup.py (path:/tmp/pip-5Rmtqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:07 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:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:07 INFO - Running setup.py (path:/tmp/pip-trIcTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:07 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:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:07 INFO - Running setup.py (path:/tmp/pip-uhpPgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:07 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:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:07 INFO - Running setup.py (path:/tmp/pip-XIn6s_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:07 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:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:07 INFO - Running setup.py (path:/tmp/pip-5McbHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:07 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:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:07 INFO - Running setup.py (path:/tmp/pip-KhP73c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:07 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:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:07 INFO - Running setup.py (path:/tmp/pip-yovp6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:07 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:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:07 INFO - Running setup.py (path:/tmp/pip-FSnLGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:08 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:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:08 INFO - Running setup.py (path:/tmp/pip-sR354C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:08 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:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:08 INFO - Running setup.py (path:/tmp/pip-a4sG06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:08 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:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:08 INFO - Running setup.py (path:/tmp/pip-afiAH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:08 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:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:08 INFO - Running setup.py (path:/tmp/pip-WSWUxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:08 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:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:08 INFO - Running setup.py (path:/tmp/pip-UZWz_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:08 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:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:08 INFO - Running setup.py (path:/tmp/pip-Kna2sZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:08 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:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:08 INFO - Running setup.py (path:/tmp/pip-VbDfZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:08 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:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:08 INFO - Running setup.py (path:/tmp/pip-e_LCGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:08 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:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:08 INFO - Running setup.py (path:/tmp/pip-Q7gtNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:08 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:52:08 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:52:08 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:52:08 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:52:08 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:52:08 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:52:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:52:08 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:52:08 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:52:08 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:52:08 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:52:08 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:52:08 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:52:10 INFO - Downloading blessings-1.6.tar.gz 04:52:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:52:10 INFO - Installing collected packages: blessings 04:52:10 INFO - Running setup.py install for blessings 04:52:10 INFO - Successfully installed blessings 04:52:10 INFO - Cleaning up... 04:52:10 INFO - Return code: 0 04:52:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:52:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:11 INFO - Reading from file tmpfile_stdout 04:52:11 INFO - Current package versions: 04:52:11 INFO - argparse == 1.2.1 04:52:11 INFO - blessings == 1.6 04:52:11 INFO - blobuploader == 1.2.4 04:52:11 INFO - docopt == 0.6.1 04:52:11 INFO - manifestparser == 1.1 04:52:11 INFO - mozInstall == 1.12 04:52:11 INFO - mozcrash == 0.17 04:52:11 INFO - mozdebug == 0.1 04:52:11 INFO - mozdevice == 0.48 04:52:11 INFO - mozfile == 1.2 04:52:11 INFO - mozhttpd == 0.7 04:52:11 INFO - mozinfo == 0.9 04:52:11 INFO - mozleak == 0.1 04:52:11 INFO - mozlog == 3.1 04:52:11 INFO - moznetwork == 0.27 04:52:11 INFO - mozprocess == 0.22 04:52:11 INFO - mozprofile == 0.28 04:52:11 INFO - mozrunner == 6.11 04:52:11 INFO - mozscreenshot == 0.1 04:52:11 INFO - mozsystemmonitor == 0.0 04:52:11 INFO - moztest == 0.7 04:52:11 INFO - mozversion == 1.4 04:52:11 INFO - psutil == 3.1.1 04:52:11 INFO - requests == 1.2.3 04:52:11 INFO - wsgiref == 0.1.2 04:52:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:11 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 0x7f4e583a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12410>, '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 0xe13310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe137a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', '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:52:11 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:52:11 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:52:11 INFO - Using env: {'DISPLAY': ':0', 04:52:11 INFO - 'HOME': '/home/cltbld', 04:52:11 INFO - 'LANG': 'en_US.UTF-8', 04:52:11 INFO - 'LANGUAGE': 'en_US:en', 04:52:11 INFO - 'LOGNAME': 'cltbld', 04:52:11 INFO - 'MAIL': '/var/mail/cltbld', 04:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:11 INFO - 'MOZ_NO_REMOTE': '1', 04:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:11 INFO - 'NO_EM_RESTART': '1', 04:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:11 INFO - 'PWD': '/builds/slave/test', 04:52:11 INFO - 'SHELL': '/bin/bash', 04:52:11 INFO - 'SHLVL': '1', 04:52:11 INFO - 'TERM': 'linux', 04:52:11 INFO - 'TMOUT': '86400', 04:52:11 INFO - 'USER': 'cltbld', 04:52:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', 04:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:11 INFO - '_': '/tools/buildbot/bin/python'} 04:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:11 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:52:11 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:52:11 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:52:11 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:52:11 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:52:11 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:52:11 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:52:11 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:52:11 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:52:11 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:52:11 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:52:11 INFO - Cleaning up... 04:52:11 INFO - Return code: 0 04:52:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:11 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 0x7f4e583a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12410>, '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 0xe13310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe137a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', '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:52:11 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:52:11 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:52:11 INFO - Using env: {'DISPLAY': ':0', 04:52:11 INFO - 'HOME': '/home/cltbld', 04:52:11 INFO - 'LANG': 'en_US.UTF-8', 04:52:11 INFO - 'LANGUAGE': 'en_US:en', 04:52:11 INFO - 'LOGNAME': 'cltbld', 04:52:11 INFO - 'MAIL': '/var/mail/cltbld', 04:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:11 INFO - 'MOZ_NO_REMOTE': '1', 04:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:11 INFO - 'NO_EM_RESTART': '1', 04:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:11 INFO - 'PWD': '/builds/slave/test', 04:52:11 INFO - 'SHELL': '/bin/bash', 04:52:11 INFO - 'SHLVL': '1', 04:52:11 INFO - 'TERM': 'linux', 04:52:11 INFO - 'TMOUT': '86400', 04:52:11 INFO - 'USER': 'cltbld', 04:52:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', 04:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:11 INFO - '_': '/tools/buildbot/bin/python'} 04:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:11 INFO - Downloading/unpacking jsonschema 04:52:11 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:52:11 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:52:11 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:52:11 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:52:11 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:52:11 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:52:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:52:13 INFO - Downloading/unpacking functools32 (from jsonschema) 04:52: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:52: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:52: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:52: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:52: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:52: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:52:13 INFO - Downloading functools32-3.2.3-2.tar.gz 04:52:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:52:13 INFO - warning: no files found matching '*.txt' 04:52:13 INFO - no previously-included directories found matching 'build' 04:52:13 INFO - no previously-included directories found matching 'dist' 04:52:13 INFO - no previously-included directories found matching '.git*' 04:52:13 INFO - Installing collected packages: jsonschema, functools32 04:52:13 INFO - Running setup.py install for functools32 04:52:13 INFO - warning: no files found matching '*.txt' 04:52:13 INFO - no previously-included directories found matching 'build' 04:52:13 INFO - no previously-included directories found matching 'dist' 04:52:13 INFO - no previously-included directories found matching '.git*' 04:52:13 INFO - Successfully installed jsonschema functools32 04:52:13 INFO - Cleaning up... 04:52:13 INFO - Return code: 0 04:52:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:52: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:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4e583a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12410>, '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 0xe13310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe137a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', '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:52: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', 'flake8'] in /builds/slave/test/build 04:52: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 flake8 04:52:13 INFO - Using env: {'DISPLAY': ':0', 04:52:13 INFO - 'HOME': '/home/cltbld', 04:52:13 INFO - 'LANG': 'en_US.UTF-8', 04:52:13 INFO - 'LANGUAGE': 'en_US:en', 04:52:13 INFO - 'LOGNAME': 'cltbld', 04:52:13 INFO - 'MAIL': '/var/mail/cltbld', 04:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:13 INFO - 'MOZ_NO_REMOTE': '1', 04:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:13 INFO - 'NO_EM_RESTART': '1', 04:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:13 INFO - 'PWD': '/builds/slave/test', 04:52:13 INFO - 'SHELL': '/bin/bash', 04:52:13 INFO - 'SHLVL': '1', 04:52:13 INFO - 'TERM': 'linux', 04:52:13 INFO - 'TMOUT': '86400', 04:52:13 INFO - 'USER': 'cltbld', 04:52:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', 04:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:13 INFO - '_': '/tools/buildbot/bin/python'} 04:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:14 INFO - Downloading/unpacking flake8 04:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:52:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:52:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:52: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:52: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:52: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:52: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:52: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:52: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:52:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:52: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:52: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:52: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:52: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:52: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:52: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:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:52:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:52:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:52:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:52:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:52:16 INFO - no previously-included directories found matching 'docs/_build' 04:52:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:52:16 INFO - Running setup.py install for pep8 04:52:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:52:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:52:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:52:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:52:16 INFO - no previously-included directories found matching 'docs/_build' 04:52:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:52:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:52:16 INFO - Cleaning up... 04:52:16 INFO - Return code: 0 04:52:16 INFO - Running post-action listener: _resource_record_post_action 04:52:16 INFO - Running post-action listener: _start_resource_monitoring 04:52:16 INFO - Starting resource monitoring. 04:52:16 INFO - ##### 04:52:16 INFO - ##### Running install step. 04:52:16 INFO - ##### 04:52:16 INFO - Running pre-action listener: _resource_record_pre_action 04:52:16 INFO - Running main action method: install 04:52:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:17 INFO - Reading from file tmpfile_stdout 04:52:17 INFO - Detecting whether we're running mozinstall >=1.0... 04:52:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:52:17 INFO - Reading from file tmpfile_stdout 04:52:17 INFO - Output received: 04:52:17 INFO - Usage: mozinstall [options] installer 04:52:17 INFO - Options: 04:52:17 INFO - -h, --help show this help message and exit 04:52:17 INFO - -d DEST, --destination=DEST 04:52:17 INFO - Directory to install application into. [default: 04:52:17 INFO - "/builds/slave/test"] 04:52:17 INFO - --app=APP Application being installed. [default: firefox] 04:52:17 INFO - mkdir: /builds/slave/test/build/application 04:52:17 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:52:17 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:52:32 INFO - Reading from file tmpfile_stdout 04:52:32 INFO - Output received: 04:52:32 INFO - /builds/slave/test/build/application/firefox/firefox 04:52:32 INFO - Running post-action listener: _resource_record_post_action 04:52:32 INFO - ##### 04:52:32 INFO - ##### Running run-tests step. 04:52:32 INFO - ##### 04:52:32 INFO - Running pre-action listener: _resource_record_pre_action 04:52:32 INFO - Running main action method: run_tests 04:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:52:32 INFO - Python 2.7.3 04:52:32 INFO - Return code: 0 04:52:32 INFO - grabbing minidump binary from tooltool 04:52: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:52:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe12410>, '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 0xe13310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe137a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:52:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:52:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:52:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:52:33 INFO - Return code: 0 04:52:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:52:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:52:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:52:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:52:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:52:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:52:33 INFO - Return code: 0 04:52:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:52:33 INFO - Using env: {'DISPLAY': ':0', 04:52:33 INFO - 'HOME': '/home/cltbld', 04:52:33 INFO - 'LANG': 'en_US.UTF-8', 04:52:33 INFO - 'LANGUAGE': 'en_US:en', 04:52:33 INFO - 'LOGNAME': 'cltbld', 04:52:33 INFO - 'MAIL': '/var/mail/cltbld', 04:52:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:52:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:33 INFO - 'MOZ_NO_REMOTE': '1', 04:52:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:33 INFO - 'NO_EM_RESTART': '1', 04:52:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:33 INFO - 'PWD': '/builds/slave/test', 04:52:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:52:33 INFO - 'SHELL': '/bin/bash', 04:52:33 INFO - 'SHLVL': '1', 04:52:33 INFO - 'TERM': 'linux', 04:52:33 INFO - 'TMOUT': '86400', 04:52:33 INFO - 'USER': 'cltbld', 04:52:33 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185', 04:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:33 INFO - '_': '/tools/buildbot/bin/python'} 04:52:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:52:34 INFO - mozversion application_buildid: 20160428034800 04:52:34 INFO - mozversion application_changeset: 830f7765555a3740103c31100118bf318cf785b2 04:52:34 INFO - mozversion application_display_name: Nightly 04:52:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:52:34 INFO - mozversion application_name: Firefox 04:52:34 INFO - mozversion application_remotingname: firefox 04:52:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:52:34 INFO - mozversion application_vendor: Mozilla 04:52:34 INFO - mozversion application_version: 49.0a1 04:52:34 INFO - mozversion platform_buildid: 20160428034800 04:52:34 INFO - mozversion platform_changeset: 830f7765555a3740103c31100118bf318cf785b2 04:52:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:52:34 INFO - mozversion platform_version: 49.0a1 04:52:34 INFO - using testdate: 1461844354 04:52:34 INFO - actual date: 1461844354 04:52:34 INFO - starting webserver on 'localhost:40163' 04:52:34 INFO - SUITE-START | Running 2 tests 04:52:34 INFO - TEST-START | dromaeo_css 04:52:34 INFO - operating with platform_type : linux_ 04:52:34 INFO - Initialising browser for dromaeo_css test... 04:52:34 INFO - TEST-INFO | started process 5337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmRm4go/profile http://localhost:40163/getInfo.html) 04:52:38 INFO - PROCESS | 5337 | 04:52:38 INFO - PROCESS | 5337 | (process:5405): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:52:39 INFO - PROCESS | 5337 | __metrics Screen width/height:1600/1200 04:52:39 INFO - PROCESS | 5337 | colorDepth:24 04:52:39 INFO - PROCESS | 5337 | Browser inner width/height: 1024/697 04:52:39 INFO - PROCESS | 5337 | __metrics 04:52:40 ERROR - PROCESS | 5337 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:52:41 INFO - TEST-INFO | 5337: exit 0 04:52:41 INFO - Browser initialized. 04:52:41 INFO - Running cycle 1/1 for dromaeo_css test... 04:52:41 INFO - TEST-INFO | started process 5456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmRm4go/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:43 INFO - PROCESS | 5456 | 04:52:43 INFO - PROCESS | 5456 | (process:5514): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:52:53 INFO - PROCESS | 5456 | RSS: Main: 166469632 04:52:53 INFO - PROCESS | 5456 | 04:53:42 INFO - PROCESS | 5456 | 1461844422741 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] 04:55:54 INFO - PROCESS | 5456 | Cycle 1(1): loaded http://localhost:40163/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40163/tests/dromaeo/cssquery-ext.html) 04:55:55 INFO - PROCESS | 5456 | RSS: Main: 170704896 04:55:55 INFO - PROCESS | 5456 | 04:58:57 INFO - PROCESS | 5456 | Cycle 1(1): loaded http://localhost:40163/tests/dromaeo/cssquery-ext.html (next: http://localhost:40163/tests/dromaeo/cssquery-jquery.html) 04:58:58 INFO - PROCESS | 5456 | RSS: Main: 166248448 04:58:58 INFO - PROCESS | 5456 | 05:02:00 INFO - PROCESS | 5456 | Cycle 1(1): loaded http://localhost:40163/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40163/tests/dromaeo/cssquery-mootools.html) 05:02:01 INFO - PROCESS | 5456 | RSS: Main: 167436288 05:02:01 INFO - PROCESS | 5456 | 05:05:03 INFO - PROCESS | 5456 | Cycle 1(1): loaded http://localhost:40163/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40163/tests/dromaeo/cssquery-prototype.html) 05:05:03 INFO - PROCESS | 5456 | RSS: Main: 165199872 05:05:03 INFO - PROCESS | 5456 | 05:08:06 INFO - PROCESS | 5456 | Cycle 1(1): loaded http://localhost:40163/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40163/tests/dromaeo/cssquery-yui.html) 05:08:06 INFO - PROCESS | 5456 | RSS: Main: 166141952 05:08:06 INFO - PROCESS | 5456 | 05:11:09 INFO - PROCESS | 5456 | Cycle 1(1): loaded http://localhost:40163/tests/dromaeo/cssquery-yui.html (next: http://localhost:40163/tests/dromaeo/cssquery-dojo.html) 05:11:09 INFO - PROCESS | 5456 | RSS: Main: 168382464 05:11:09 INFO - PROCESS | 5456 | 05:11:09 INFO - PROCESS | 5456 | __start_tp_report 05:11:09 INFO - PROCESS | 5456 | _x_x_mozilla_page_load 05:11:09 INFO - PROCESS | 5456 | _x_x_mozilla_page_load_details 05:11:09 INFO - PROCESS | 5456 | |i|pagename|runs| 05:11:09 INFO - PROCESS | 5456 | |0;dojo.html;2661.7205193454683;2719.415325704973;2748.917532474024;2758.9724102758964;2761.351082495612;4794.208955522335;4848.854534363971;4858.1983972644475;4872.2448020556785;4918.557329840313;4750.714957102577;4794.616430685545;4854.6844455110395;4895.730734809584;4906.950930490703;4430.158269928711;4475.28395456727;4522.027764030733;4524.163029839474;4568.1548913451115;623.790829472408;4230.74615523068;4338.739675619458;4387.605115539601;4439.866803995886;4386.078923426085;4401.185780630593;4408.581184787472;4414.161309351245;4439.089986552749;4391.538888416734;4398.780060996937;4437.711548749321;4461.24158892989;4476.194285028693;4292.957070429318;4377.715448495837;4390.62679672225;4419.226635338835;4457.064016556527;4637.281221410687;4655;4684.437867455893;4688.531146885318;4750.809967601292;5118.07874582575;5124.205748109011;5127.359080114986;5129.256257842592;5174.016936781999;5222.529972302473;5231;5238.607104467142;5250.343707036621;5290.788368465257;4855.0584285622235;4855.732934688591;4858.3441235432765;4859.07677541266;4871.658983871095;5142.948570514322;5169.53474187325;5263.236830659533;5344.5724342052545;5348.171033489815;5114.820981265712;5125.410577783603;5131.5638170755155;5140.408852981955;5164.2770012198325;5216.739163041909;5231.875146843371;5232.2413250078525;5242.659227150223;5288.444713305124;4949.133901567211;5133.486651334837;5164.9741751291;5192.117340052125;5197.610179236573;5122.641415100908;5129.435762066169;5145.382554093533;5149.45930677281;5153.2270159476375;3996.1208534122447;4018.176273863851;4019.83920643171;4022.879313620596;4048.4939382577177;3434.4504879219703;3520.753547251719;3571.589267234301;3599.1721903962234;3627.038834708804;4438.667099967451;4512.842050528216;4542.227821270392;4561;4587.449506059227;5188;5202.479752024768;5205.9219111713355;5214.45248248936;5251.789928402897;4414.55854414556;4503.752293623882;4549.067441174551;4553.430821147356;4573.81704731807;4635.745034023161;4652.325412815123;4676.976615116971;4683.7892294846815;4719.905601887943;4887.169181239198;4909.26361045846;4948.826791062295;4959.90080198394;5002.499750024968;5005.574526165171;5141.691498510101;5183.792648294026;5227.89544209106;5236.528712415901;4895.216765317532;4903.411590609007;4944.75276236194;4948.035133149001;5011.072951503984;4937.185364414831;5060.114479966065;5122.052420302256;5130.204818253177;5130.333056702605;5197.584193264605;5199.168133098686;5201.713905735221;5201.973990130025;5260.473952604862;4998.950010499994;5018.799248030038;5044.646874718881;5046.571041461517;5074.416442109057;4853.174960256835;4968.900621987612;4979.203327467588;4985.4266759323145;4992.950070499249;4926.088673595396;4946.4558898521855;4995.450500445021;5002.699838009731;5026.3214466048075;5085.237214417719;5088.389393272831;5104.642675012862;5105.566026887756;5166.225066240094;4793.784279707491;4930.7534623267975;4933.6432481068;4937.259411088222;4939.259111133359 05:11:09 INFO - PROCESS | 5456 | |1;ext.html;564.1847530318691;583.8832233553289;597.9625350017718;607.1894021481321;637.3212528656977;30976.845115774417;31763.841180794065;31903.36193276133;31935.680643193562;32012.83993580032;32079.67920320796;32845.83577082117;33002.66997330026;33055.504167437444;33121.50317745236;7501.924980750177;7637.847243055136;7686.846263074735;7691.42314326425;7712.730054448096;7572.129205141397;7836.255555722198;7840.764777056697;7848.803779905491;7876.212378762107;7807.102183248914;7869.606519674022;7883.2510911463605;7896.249856263675;7900.170482099383;7802.8439431211345;7830.29527342539;7856.882146767803;7890.9605451972375;7894.881576776324;7702.614869256515;7811.062672479282;7811.140774514799;7815.804604884866;7825.256600622932;24599.63100553493;33394.49908251378;33495.162620934425;33676.831615841766;33786.83106584476;2916.8833246670106;3035.362573859492;3059.969400305991;3408.6761757632985;3420.846061927219;26010.86994565034;26045;26065.08772192983;26311.342216444744;26427.207183784325;3301.1747063234193;3409.829508524564;3460.4290292101773;3462.480627905809;3464.9133771655656;161261;164343;164702.176489118;165622;165959.1702041494;53980;54724.0748332652;54751;54803.451965479835;54808.72595636996;51445;52262;52483;52543.211851822256;52632;14791.408343666348;14796.70406591862;14818.184999825113;14932.402703891723;14966.326515306837;11348.886511134948;11397.829032564518;11478.19652624325;11481.655550333504;11544.422778861192;17211.827881721274;17307.480775576754;17450.301987920342;17503.73744393835;18214.36249731253;7128.893066604005;7409.444291678145;7449.627518624047;7463;7488.812779680443;865.5845194306768;914.6021480655936;977.1791694976254;982.4547376206132;1009.8384258518602;25850.870745646152;26375.47249055008;26797.732022679913;27233.45533089327;27403.588946165823;929.3123088914155;989.5992123190119;1005.8642083318658;1028.6142696488816;1039.8544203811473;14207.147571145764;14349.35427905726;14372.568822935329;14427.3507692152;14429.20639364845;200295;205991;206449;207950;207951;44934;45542.77228613836;45642.08715825665;45898;46037.7698111514;1282.4421376701164;1284.3321472834075;1289.8387701537308;1292.5669900583223;1318.5780550223835;25677.229683109537;26583.867080665248;26672.733272667025;26767.330816729736;27531.724682753716;39679.801600991814;40471.392929106674;40481.797591011855;40520.18959620732;40525.39211911765;213715;214728;215195;215550;215755;23932.162374316817;24093.277201683977;24314.878425608465;24370.75629243756;24635.260942171764;37126;37843;37989.24021519609;38153.80923095478;38377.80811096038;32544.51183232206;32816.835915820266;32933.200677941684;33435;33448.1637959053;32470.837645811618;32517.34965300728;32646.34707305888;33129.337413251116;33328.1667958303;26237.34406639849;29370.412591748474;29965.101046968626;31981;32215.838920805247;28477.857610711813;28898.27754306159;29283.267918302212;29464.410711785215;29754.702452975194;22908.4272893179;23384.372438883493;23613.409664758517;23777.167799126946;23797.881010594836 05:11:09 INFO - PROCESS | 5456 | |2;jquery.html;386.2024918543208;387.38986096897384;390.81534713164183;392.91159489114955;402.67785771382887;12274.447649855756;14882.330295136719;14937.17845518496;15434.536963891072;15592.45426410076;14658.63353416165;14902.40390384386;15153.24233788309;16612.750808737877;16648.33406663732;4935.802567897289;5004.8238663914135;5156.226566015109;5159.484051594848;5181.0933086709865;5054;5105;5127.487251274862;5131.820386286481;5142.768575414116;5074.238864170386;5081.949180508184;5092.236164575306;5095.770690318926;5102.872428189288;4825.662203645747;5001.499850014988;5016.774245158977;5022.84931452057;5046.09170349337;4479.7984090716;4495.730256184606;4504.1892459357305;4532.229520981441;4536.9791796845775;17156.399526016656;18315.175817088264;19315.4205373839;19469;19534.90232548828;1849.4174335084406;1901.7337572739827;2054.41449186981;2364.5034542746043;2474.9357776156244;8720;9100.908990910073;9134.543272836332;11457.36984465854;12035.57875474363;1641.1794102948527;1712.7773389459414;1743.921523531444;1754.1843042985074;1800.2349001674368;59869.70065149647;60197;60506.394936050514;60874;60992.695036524536;9319.301052421095;9710.563024663907;9762.36544624597;9975.501224938724;10324.741881452874;12083.758324833454;12766.61700148997;13850.65373365674;13919.582412527641;13961.115249441398;6876.759313424006;7031.367176953996;7130.393916517154;7219.133703955559;7229.89155162673;6686.063951046857;6695.899561506581;6700;6821.283765204681;6891.552049116792;4276.615104640598;4356.586124318184;4387.868363949086;4437.511873693891;4456.24243878535;1807.9005654689117;1864.3567969050655;1889.7921228664836;1929.6816025355658;1947.7662680478434;793.4287313134533;884.6903583745766;904.69692652962;927.4806108579218;937.4562753602894;14789.186594737177;15615.921920390325;15671.921640391725;15934.92032539853;16519.174041297887;879.9340049496313;891.1712107739864;896.1397058823472;903.5888670654837;909.2634965677822;9320.8601870972;9342.982801301023;9355.625774969061;9382.67160649374;9447.149756521809;362275;363540;364260;365177;372336;63616;64110.679446602466;64175.35824641787;64665.35334646687;67805.32194678088;909.9636014559344;917.6283605139796;929.3773171974793;944.3436811416137;950.6577632052456;14345.64135896611;14351.349594796731;14427.134371937716;14438.494652687106;14595;23030.769692302863;32151.196220094684;32319;32349.191270218435;32500.187495312806;42168.1566368677;42486.36270456007;43136.568634313255;43360.783196083816;43689.56310436855;7639.923600764144;7773.805654858674;7783.260590243918;7791.805204869697;7851.528908265523;10247.411651194077;11104.222704410613;11387.487563059516;11524.884751152382;11546.94226528862;9808.117269445784;9945.850812237677;10083.193344532274;10117.544710488193;10169.389836609827;10221.131203847755;10277.126444252322;10334.844977325196;10403;10518.737031574272;10030.147437467896;10047;10120.746981325527;10170.338927969658;10191.643292484727;7565.356944659546;7624.504407213735;7662.6934922604705;7682.7311044113185;7964.362850971793;7707.884381734167;9987.550560224661;10302.690919272434;10373.222008349554;10570.41862697559 05:11:09 INFO - PROCESS | 5456 | |3;mootools.html;1425.672095418054;1439.352291468839;1577.148339896456;1710.4783041172439;1737.0012242960292;6644.900326495094;7229.891551626723;7356.816079598013;7551.471397002212;7587.317141457274;7431.628418579063;7486.775396738093;7523.887141692879;7524.946507488956;7537.359324457414;2226.0428015953134;2241.8094461970754;2261.0616594113503;2261.4459457432954;2262.366537369539;2217.7227846519186;2237.2393386248673;2255.4925141843037;2256.26671331817;2267.1384873748034;2214.357836227492;2227.3095340444515;2238.8656680599133;2244.9438764030947;2249.5500899820017;2187.595294870454;2203.5813195492806;2210.1159536185573;2211.281333566589;2212.303124515772;2177.6298029335053;2190.8028277455105;2196.2313190383397;2209.4807720185745;2213.7786221377896;7634.312911837961;7649.655765490566;7676.347510461562;7676.80807979805;7679.654415551314;4585.79363928624;4796.664233503621;4814.7833347499445;4820;4850.029994001214;2860.7711383089304;3061.2959019425434;3066.0801759472292;3097.287623846528;3101.069679096262;933.1275257634067;943.3820847344931;948.7106432538073;976.8681228034267;1018.3889666200295;10163.034511721375;10196;10197.694069177862;10204;10222.642207522775;4248.8300467980935;4305.375720520507;4339.956600434019;4375.912481750347;4375.912481750347;8734.213920747163;8780.42927209742;8793.824123517494;8841.734747957571;8849.247813935888;4718;4773.307870358848;4775.379200703886;4778.092162489116;4805.471398146201;3751.4935483709896;4203.747775133502;4240.978795106004;4319.43847299849;4384.145091707086;3615.8011309378235;3666.7616604920595;3721.4603882436895;3753.9249215016093;3781.1303400218103;1252.1547955130434;1276.1003492537739;1282.4805953588811;1289.8323217981601;1298.8571257161705;732.5055587478431;759.236966848314;795.9044914610168;843.9535825529655;911.7401540560908;4874.5856602188505;4914.606831453475;4993.700377977333;5128.871778205575;5594.664320140804;902.4585248850638;954.7947191353892;955.2405837359316;958.9089036541517;964.1226483899618;3587.8385472653795;3612.2414292998237;3724.8696295630066;3745.194783121642;3807.8857634271017;8918.331125165638;9207.76980575491;9294.977552469223;9364.906350936404;9393.107654772786;9029.729108126767;9138.360314778034;9150.130737579919;9288.024757400512;9307.3019523536;7056.400205982549;7153.427725781925;7195.89206161908;7231.385332246818;7275.4179665626625;5206.479352064764;5210.348706411699;5243.528082472596;5255.684658920324;5308.893822123613;8305.83388332242;8590.527520986405;8752.256058235122;8775.210231079234;8856.424332418372;8725;8736.432131911406;8770.824583508422;8794.076621954602;8900.287976961958;5737.9139312911175;6110.114033465212;6297.023961286008;6334.398232167937;6351.587146835441;7183.066201393785;7190.460715446257;7236.4210863131875;7243.058402407864;7264.527805692613;6400.583962042452;6575.2767195607485;6597.967010164918;6694.062831203538;6696.296888826798;6263.09185168139;6297;6343.9682801585695;6369.649669268235;6379.170707807955;6205.286392064971;6348.365163483615;6353.841153971188;6362.427381535684;6413.871722565429;4431.3352997049415;4607.101615185007;4622.768861556841;4676.158291507425;4696.483386827378;4420.955790442054;4512.368268442355;4562.794674239601;4615.26155815068;4638.211504044253 05:11:09 INFO - PROCESS | 5456 | |4;prototype.html;299.81411524854593;303.6235068515041;306.3887544349024;307.9645840728317;311.6307175996443;4930.778114984825;4967.552920237178;4991.700497970124;4997.900041999158;5006.474320196382;4868.318435419044;4875.756212189394;4887.608991280698;4895.11887860185;4905.362302900627;3682.3555877721424;3794.392897136459;3863.98068009661;3903.6486716195536;3914.725969182158;3876.263509933118;3892.4355968384566;3902.7072969527258;3904.9804750976205;3946.940795888064;3879.7478163919395;3890.1636148228126;3893.415987601854;3900.668443182333;3904.4533765272886;3797.6012518685693;3884.961150388502;3886.455896174524;3899.161680238734;3914.3149948758855;3427.9143021424416;3452.3440546296124;3452.912332615218;3453.568303962005;3461.446168613035;4718.386609740712;4725.291206319045;4730.148573256813;4733.526647335273;4760.238361862085;4394.868153955386;4426.3581780641625;4430.712003719748;4445.310392374322;4449.688521803475;4931.112399768041;5153.685810118396;5154.355705536808;5156.974215128937;5211.557017653504;3591.8024508652015;3613.313470440608;3627.9818600907092;3635.800030998294;3644.0889777555612;5360.865978350534;5371.113766228567;5386.542143917733;5425.131978883399;5448.727563621803;3629.91280013993;3642.8724994625063;3727.813609319523;3739.2521495700967;3747.737658363943;3774.169682669808;3781.829817658212;3795.7342985990717;3804.4483549885113;3809.1810260794064;4315.762633055149;4316.7409955402145;4346.695731298779;4351.804168812411;4372.409724687126;5029.647924645313;5159.703931750335;5174.611904107207;5184.766685499161;5204.843854684365;1360.6190266725332;1378.6415531961761;1378.8552202018843;1379.6895698467765;1380.7997840313099;846.4540371460373;894;894.7763059235191;912.3476714149415;912.8174365127002;4548;4644.187267228222;4647.86056418308;4650.348951146842;4681.204195286809;5311.7344132793205;5317.946820531745;5350.812721554805;5358.258565965999;5358.517733404013;4524.25349817283;4602.792874320664;4620.768961551909;4641.698289611165;4643.512431194744;3034.4689679306034;3041.4373340931556;3049.283418396675;3063.417950589381;3092.5515800209296;5414.91877621836;5422.728863556807;5441.918371224435;5466.644668096561;5477.780888764484;5665.5467562594895;5875.206847075676;5885.323187833454;5887.911681324784;5892.234009578728;5457.317835270591;5466.316710411199;5473.38535132137;5485.232067510552;5494.2857428535635;5721.942780572141;5723.599348045597;5736.168255602997;5746.304840072105;5749;5004.4495105537635;5288.2860813791185;5307.681539107666;5316.2823018893505;5355.169948657965;5146.871328216825;5153.3043039190725;5170.793168273227;5173.948260517347;5187.1181899078;3716.7026637869444;3747.632114278323;3760.9059773505883;3774.7923864186637;3780.4896338993885;5160.354955630546;5325.653832500875;5350.652207606493;5369.0872551665525;5377.897531006212;5166.8966620668125;5197.8440646780655;5207.6875387476875;5212.322398088224;5245.6852588844795;5010.599152067899;5172.301739265151;5181.1969144782615;5206.349206349207;5206.73966301691;5122.206058061007;5122.718250496258;5160.793568257378;5168.560672342893;5170;4942.5304596063315;5048.8990220194655;5207;5267.552258058108;5270.578353731616;5045.899082018265;5090.694558326512;5115.104856649997;5117.618243074424;5135 05:11:09 INFO - PROCESS | 5456 | |5;yui.html;648.627039452315;675.5507587454343;768.8539177556264;783.4672422752533;799.5842162075725;11815.822762658556;12146.69633259169;12177.634670959875;12231.510739570407;12236.20464669796;11077.50151243194;11106.27809192402;11150.442477876115;11321.377324247163;11323.660290191307;636.8853606350855;789.3882241263038;789.3921680306175;813.0527934955769;813.9023317201915;811.8213992921577;816.5753808019826;817.3461231015194;817.4686453805044;817.840521098386;850.1073872433919;852.5779739029189;854.0306751836679;854.3592305770673;854.3976496569903;846.7713717296357;846.8391005708895;849.3247867944998;849.9235068843802;851.5231470376609;615.2186722861941;616.214326733414;619.5105866365566;619.9690015499207;622.794477822322;12323.753524929542;12344.321062341567;12383.071269654722;12392.876071239352;12446.688832779162;12692.873071269261;12881.098323117385;12935.288559129243;12983.805242921364;13022.413991370317;9984.25118116137;9993.900060999369;10069.043440873105;10130.696079117639;10145.847812282822;3339.7662163648556;3426.468897320919;3439.8108104054268;3515.4726790981304;3547.130952916526;44128.11743765107;44445.77777111094;44602.77698611518;45605.543944560464;46294.537054629356;10274.280800343904;10283.9485802572;10320.380777153396;10333.586656533806;10604.416757078434;17711.557211069827;17755.73366399505;17785.644287114184;17844.9107754463;17955.910220449074;6755.4257888080065;7027.964860175666;7069.116360454943;7088.610126443095;7111.679974401164;3805.6955443564448;3836.3286424875537;3856.8842934712;3898.5126859142606;3907.1404291055924;2847.288177955511;2893.3923875985856;2893.7540309073543;2907.636545431821;2917.693642167584;498.7930009046205;517.1802692731986;525.6609486881017;529.1110933631536;532.5287120897956;488.11650911849665;562.2887047884429;576.9451902069296;589.3311091910713;596.931352894414;7511.774646760606;7571;7836.960815195887;7946.086200086948;7997.960010200029;441.36002795946007;459.1001636791925;504.70222568684653;532.934131736527;574.3538519165938;3927.9803600981813;4084.162746636992;4136.193442278787;4190.161967606491;4360.65114790816;55808.441915580326;56564.15153772697;56984.715076424356;58001.4199857996;58495.70752146297;51033.234501482504;51270;51477;51991.22013169806;54201.72899135558;46004.76997614923;46440.767796160806;46585.5341446588;47106.293405598946;47497.28754068692;8420.621072051896;8450.704225352083;8551.35864810154;8698.865452221167;8817.25053370445;27711.58432623472;28687.282817929718;29049.12852614425;30691.386172275983;30882.382352353277;38889.6111038886;38898;39123;39504.60495395009;39583.2083358337;10457.320274182153;10582.682519524427;10584.89415105839;10638.255322127377;10650.73373165677;11435.714107147054;11510.30938143714;11807.409629518317;12067.155299129328;12971.221726696429;11389.544418223179;11797.469113890067;11843.220973035262;11856.525738970344;12095.637130886087;10715.035646791826;10918.836217456586;10939;11304.49129789145;11462.770744585228;11695.941520292345;11699.356535390636;11764.764704706029;12150.088743344108;12183.695407614881;9590.03447008469;9613.759656008655;9637.18083962871;9734.951325243328;10203.438810865473;9587.904120958701;10245;10260.023184234791;10348.637797677346;10471.267011309135 05:11:09 INFO - PROCESS | 5456 | __end_tp_report 05:11:09 INFO - PROCESS | 5456 | __start_cc_report 05:11:09 INFO - PROCESS | 5456 | _x_x_mozilla_cycle_collect,364 05:11:09 INFO - PROCESS | 5456 | __end_cc_report 05:11:09 INFO - PROCESS | 5456 | __startTimestamp1461845469763__endTimestamp 05:11:09 INFO - PROCESS | 5456 | 05:11:09 INFO - PROCESS | 5456 | ------- Summary: start ------- 05:11:09 INFO - PROCESS | 5456 | Number of tests: 6 05:11:09 INFO - PROCESS | 5456 | 05:11:09 INFO - PROCESS | 5456 | [#0] dojo.html Cycles:165 Average:4739.83 Median:4933.64 stddev:620.95 (12.6%) stddev-sans-first:601.07 05:11:09 INFO - PROCESS | 5456 | Values: 2661.7 2719.4 2748.9 2759.0 2761.4 4794.2 4848.9 4858.2 4872.2 4918.6 4750.7 4794.6 4854.7 4895.7 4907.0 4430.2 4475.3 4522.0 4524.2 4568.2 623.8 4230.7 4338.7 4387.6 4439.9 4386.1 4401.2 4408.6 4414.2 4439.1 4391.5 4398.8 4437.7 4461.2 4476.2 4293.0 4377.7 4390.6 4419.2 4457.1 4637.3 4655.0 4684.4 4688.5 4750.8 5118.1 5124.2 5127.4 5129.3 5174.0 5222.5 5231.0 5238.6 5250.3 5290.8 4855.1 4855.7 4858.3 4859.1 4871.7 5142.9 5169.5 5263.2 5344.6 5348.2 5114.8 5125.4 5131.6 5140.4 5164.3 5216.7 5231.9 5232.2 5242.7 5288.4 4949.1 5133.5 5165.0 5192.1 5197.6 5122.6 5129.4 5145.4 5149.5 5153.2 3996.1 4018.2 4019.8 4022.9 4048.5 3434.5 3520.8 3571.6 3599.2 3627.0 4438.7 4512.8 4542.2 4561.0 4587.4 5188.0 5202.5 5205.9 5214.5 5251.8 4414.6 4503.8 4549.1 4553.4 4573.8 4635.7 4652.3 4677.0 4683.8 4719.9 4887.2 4909.3 4948.8 4959.9 5002.5 5005.6 5141.7 5183.8 5227.9 5236.5 4895.2 4903.4 4944.8 4948.0 5011.1 4937.2 5060.1 5122.1 5130.2 5130.3 5197.6 5199.2 5201.7 5202.0 5260.5 4999.0 5018.8 5044.6 5046.6 5074.4 4853.2 4968.9 4979.2 4985.4 4993.0 4926.1 4946.5 4995.5 5002.7 5026.3 5085.2 5088.4 5104.6 5105.6 5166.2 4793.8 4930.8 4933.6 4937.3 4939.3 05:11:09 INFO - PROCESS | 5456 | 05:11:09 INFO - PROCESS | 5456 | [#1] ext.html Cycles:180 Average:35539.92 Median:32530.93 stddev:50829.37 (156.2%) stddev-sans-first:50904.12 05:11:09 INFO - PROCESS | 5456 | Values: 564.2 583.9 598.0 607.2 637.3 30976.8 31763.8 31903.4 31935.7 32012.8 32079.7 32845.8 33002.7 33055.5 33121.5 7501.9 7637.8 7686.8 7691.4 7712.7 7572.1 7836.3 7840.8 7848.8 7876.2 7807.1 7869.6 7883.3 7896.2 7900.2 7802.8 7830.3 7856.9 7891.0 7894.9 7702.6 7811.1 7811.1 7815.8 7825.3 24599.6 33394.5 33495.2 33676.8 33786.8 2916.9 3035.4 3060.0 3408.7 3420.8 26010.9 26045.0 26065.1 26311.3 26427.2 3301.2 3409.8 3460.4 3462.5 3464.9 161261.0 164343.0 164702.2 165622.0 165959.2 53980.0 54724.1 54751.0 54803.5 54808.7 51445.0 52262.0 52483.0 52543.2 52632.0 14791.4 14796.7 14818.2 14932.4 14966.3 11348.9 11397.8 11478.2 11481.7 11544.4 17211.8 17307.5 17450.3 17503.7 18214.4 7128.9 7409.4 7449.6 7463.0 7488.8 865.6 914.6 977.2 982.5 1009.8 25850.9 26375.5 26797.7 27233.5 27403.6 929.3 989.6 1005.9 1028.6 1039.9 14207.1 14349.4 14372.6 14427.4 14429.2 200295.0 205991.0 206449.0 207950.0 207951.0 44934.0 45542.8 45642.1 45898.0 46037.8 1282.4 1284.3 1289.8 1292.6 1318.6 25677.2 26583.9 26672.7 26767.3 27531.7 39679.8 40471.4 40481.8 40520.2 40525.4 213715.0 214728.0 215195.0 215550.0 215755.0 23932.2 24093.3 24314.9 24370.8 24635.3 37126.0 37843.0 37989.2 38153.8 38377.8 32544.5 32816.8 32933.2 33435.0 33448.2 32470.8 32517.3 32646.3 33129.3 33328.2 26237.3 29370.4 29965.1 31981.0 32215.8 28477.9 28898.3 29283.3 29464.4 29754.7 22908.4 23384.4 23613.4 23777.2 23797.9 05:11:09 INFO - PROCESS | 5456 | 05:11:09 INFO - PROCESS | 5456 | [#2] jquery.html Cycles:180 Average:22355.85 Median:24038.72 stddev:60009.05 (249.6%) stddev-sans-first:60154.71 05:11:09 INFO - PROCESS | 5456 | Values: 386.2 387.4 390.8 392.9 402.7 12274.4 14882.3 14937.2 15434.5 15592.5 14658.6 14902.4 15153.2 16612.8 16648.3 4935.8 5004.8 5156.2 5159.5 5181.1 5054.0 5105.0 5127.5 5131.8 5142.8 5074.2 5081.9 5092.2 5095.8 5102.9 4825.7 5001.5 5016.8 5022.8 5046.1 4479.8 4495.7 4504.2 4532.2 4537.0 17156.4 18315.2 19315.4 19469.0 19534.9 1849.4 1901.7 2054.4 2364.5 2474.9 8720.0 9100.9 9134.5 11457.4 12035.6 1641.2 1712.8 1743.9 1754.2 1800.2 59869.7 60197.0 60506.4 60874.0 60992.7 9319.3 9710.6 9762.4 9975.5 10324.7 12083.8 12766.6 13850.7 13919.6 13961.1 6876.8 7031.4 7130.4 7219.1 7229.9 6686.1 6695.9 6700.0 6821.3 6891.6 4276.6 4356.6 4387.9 4437.5 4456.2 1807.9 1864.4 1889.8 1929.7 1947.8 793.4 884.7 904.7 927.5 937.5 14789.2 15615.9 15671.9 15934.9 16519.2 879.9 891.2 896.1 903.6 909.3 9320.9 9343.0 9355.6 9382.7 9447.1 362275.0 363540.0 364260.0 365177.0 372336.0 63616.0 64110.7 64175.4 64665.4 67805.3 910.0 917.6 929.4 944.3 950.7 14345.6 14351.3 14427.1 14438.5 14595.0 23030.8 32151.2 32319.0 32349.2 32500.2 42168.2 42486.4 43136.6 43360.8 43689.6 7639.9 7773.8 7783.3 7791.8 7851.5 10247.4 11104.2 11387.5 11524.9 11546.9 9808.1 9945.9 10083.2 10117.5 10169.4 10221.1 10277.1 10334.8 10403.0 10518.7 10030.1 10047.0 10120.7 10170.3 10191.6 7565.4 7624.5 7662.7 7682.7 7964.4 7707.9 9987.6 10302.7 10373.2 10570.4 05:11:09 INFO - PROCESS | 5456 | 05:11:09 INFO - PROCESS | 5456 | [#3] mootools.html Cycles:180 Average:5051.00 Median:5208.41 stddev:2714.50 (52.1%) stddev-sans-first:2708.45 05:11:09 INFO - PROCESS | 5456 | Values: 1425.7 1439.4 1577.1 1710.5 1737.0 6644.9 7229.9 7356.8 7551.5 7587.3 7431.6 7486.8 7523.9 7524.9 7537.4 2226.0 2241.8 2261.1 2261.4 2262.4 2217.7 2237.2 2255.5 2256.3 2267.1 2214.4 2227.3 2238.9 2244.9 2249.6 2187.6 2203.6 2210.1 2211.3 2212.3 2177.6 2190.8 2196.2 2209.5 2213.8 7634.3 7649.7 7676.3 7676.8 7679.7 4585.8 4796.7 4814.8 4820.0 4850.0 2860.8 3061.3 3066.1 3097.3 3101.1 933.1 943.4 948.7 976.9 1018.4 10163.0 10196.0 10197.7 10204.0 10222.6 4248.8 4305.4 4340.0 4375.9 4375.9 8734.2 8780.4 8793.8 8841.7 8849.2 4718.0 4773.3 4775.4 4778.1 4805.5 3751.5 4203.7 4241.0 4319.4 4384.1 3615.8 3666.8 3721.5 3753.9 3781.1 1252.2 1276.1 1282.5 1289.8 1298.9 732.5 759.2 795.9 844.0 911.7 4874.6 4914.6 4993.7 5128.9 5594.7 902.5 954.8 955.2 958.9 964.1 3587.8 3612.2 3724.9 3745.2 3807.9 8918.3 9207.8 9295.0 9364.9 9393.1 9029.7 9138.4 9150.1 9288.0 9307.3 7056.4 7153.4 7195.9 7231.4 7275.4 5206.5 5210.3 5243.5 5255.7 5308.9 8305.8 8590.5 8752.3 8775.2 8856.4 8725.0 8736.4 8770.8 8794.1 8900.3 5737.9 6110.1 6297.0 6334.4 6351.6 7183.1 7190.5 7236.4 7243.1 7264.5 6400.6 6575.3 6598.0 6694.1 6696.3 6263.1 6297.0 6344.0 6369.6 6379.2 6205.3 6348.4 6353.8 6362.4 6413.9 4431.3 4607.1 4622.8 4676.2 4696.5 4421.0 4512.4 4562.8 4615.3 4638.2 05:11:09 INFO - PROCESS | 5456 | 05:11:09 INFO - PROCESS | 5456 | [#4] prototype.html Cycles:180 Average:4363.01 Median:4930.95 stddev:1281.47 (26.0%) stddev-sans-first:1248.25 05:11:09 INFO - PROCESS | 5456 | Values: 299.8 303.6 306.4 308.0 311.6 4930.8 4967.6 4991.7 4997.9 5006.5 4868.3 4875.8 4887.6 4895.1 4905.4 3682.4 3794.4 3864.0 3903.6 3914.7 3876.3 3892.4 3902.7 3905.0 3946.9 3879.7 3890.2 3893.4 3900.7 3904.5 3797.6 3885.0 3886.5 3899.2 3914.3 3427.9 3452.3 3452.9 3453.6 3461.4 4718.4 4725.3 4730.1 4733.5 4760.2 4394.9 4426.4 4430.7 4445.3 4449.7 4931.1 5153.7 5154.4 5157.0 5211.6 3591.8 3613.3 3628.0 3635.8 3644.1 5360.9 5371.1 5386.5 5425.1 5448.7 3629.9 3642.9 3727.8 3739.3 3747.7 3774.2 3781.8 3795.7 3804.4 3809.2 4315.8 4316.7 4346.7 4351.8 4372.4 5029.6 5159.7 5174.6 5184.8 5204.8 1360.6 1378.6 1378.9 1379.7 1380.8 846.5 894.0 894.8 912.3 912.8 4548.0 4644.2 4647.9 4650.3 4681.2 5311.7 5317.9 5350.8 5358.3 5358.5 4524.3 4602.8 4620.8 4641.7 4643.5 3034.5 3041.4 3049.3 3063.4 3092.6 5414.9 5422.7 5441.9 5466.6 5477.8 5665.5 5875.2 5885.3 5887.9 5892.2 5457.3 5466.3 5473.4 5485.2 5494.3 5721.9 5723.6 5736.2 5746.3 5749.0 5004.4 5288.3 5307.7 5316.3 5355.2 5146.9 5153.3 5170.8 5173.9 5187.1 3716.7 3747.6 3760.9 3774.8 3780.5 5160.4 5325.7 5350.7 5369.1 5377.9 5166.9 5197.8 5207.7 5212.3 5245.7 5010.6 5172.3 5181.2 5206.3 5206.7 5122.2 5122.7 5160.8 5168.6 5170.0 4942.5 5048.9 5207.0 5267.6 5270.6 5045.9 5090.7 5115.1 5117.6 5135.0 05:11:09 INFO - PROCESS | 5456 | 05:11:09 INFO - PROCESS | 5456 | [#5] yui.html Cycles:180 Average:13264.89 Median:4163.18 stddev:15380.83 (369.4%) stddev-sans-first:15394.79 05:11:09 INFO - PROCESS | 5456 | Values: 648.6 675.6 768.9 783.5 799.6 11815.8 12146.7 12177.6 12231.5 12236.2 11077.5 11106.3 11150.4 11321.4 11323.7 636.9 789.4 789.4 813.1 813.9 811.8 816.6 817.3 817.5 817.8 850.1 852.6 854.0 854.4 854.4 846.8 846.8 849.3 849.9 851.5 615.2 616.2 619.5 620.0 622.8 12323.8 12344.3 12383.1 12392.9 12446.7 12692.9 12881.1 12935.3 12983.8 13022.4 9984.3 9993.9 10069.0 10130.7 10145.8 3339.8 3426.5 3439.8 3515.5 3547.1 44128.1 44445.8 44602.8 45605.5 46294.5 10274.3 10283.9 10320.4 10333.6 10604.4 17711.6 17755.7 17785.6 17844.9 17955.9 6755.4 7028.0 7069.1 7088.6 7111.7 3805.7 3836.3 3856.9 3898.5 3907.1 2847.3 2893.4 2893.8 2907.6 2917.7 498.8 517.2 525.7 529.1 532.5 488.1 562.3 576.9 589.3 596.9 7511.8 7571.0 7837.0 7946.1 7998.0 441.4 459.1 504.7 532.9 574.4 3928.0 4084.2 4136.2 4190.2 4360.7 55808.4 56564.2 56984.7 58001.4 58495.7 51033.2 51270.0 51477.0 51991.2 54201.7 46004.8 46440.8 46585.5 47106.3 47497.3 8420.6 8450.7 8551.4 8698.9 8817.3 27711.6 28687.3 29049.1 30691.4 30882.4 38889.6 38898.0 39123.0 39504.6 39583.2 10457.3 10582.7 10584.9 10638.3 10650.7 11435.7 11510.3 11807.4 12067.2 12971.2 11389.5 11797.5 11843.2 11856.5 12095.6 10715.0 10918.8 10939.0 11304.5 11462.8 11695.9 11699.4 11764.8 12150.1 12183.7 9590.0 9613.8 9637.2 9735.0 10203.4 9587.9 10245.0 10260.0 10348.6 10471.3 05:11:09 INFO - PROCESS | 5456 | -------- Summary: end -------- 05:11:09 INFO - PROCESS | 5456 | 05:11:10 INFO - TEST-INFO | 5456: exit 0 05:11:10 INFO - TEST-OK | dromaeo_css | took 1116321ms 05:11:10 INFO - TEST-START | kraken 05:11:10 INFO - operating with platform_type : linux_ 05:11:10 INFO - Initialising browser for kraken test... 05:11:10 INFO - TEST-INFO | started process 5689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr737iz/profile http://localhost:40163/getInfo.html) 05:11:14 INFO - PROCESS | 5689 | 05:11:14 INFO - PROCESS | 5689 | (process:5755): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:11:15 INFO - PROCESS | 5689 | __metrics Screen width/height:1600/1200 05:11:15 INFO - PROCESS | 5689 | colorDepth:24 05:11:15 INFO - PROCESS | 5689 | Browser inner width/height: 1024/697 05:11:15 INFO - PROCESS | 5689 | __metrics 05:11:16 ERROR - PROCESS | 5689 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:11:16 INFO - TEST-INFO | 5689: exit 0 05:11:16 INFO - Browser initialized. 05:11:16 INFO - Running cycle 1/1 for kraken test... 05:11:16 INFO - TEST-INFO | started process 5806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr737iz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:18 INFO - PROCESS | 5806 | 05:11:18 INFO - PROCESS | 5806 | (process:5865): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:11:28 INFO - PROCESS | 5806 | RSS: Main: 166334464 05:11:28 INFO - PROCESS | 5806 | 05:11:31 INFO - PROCESS | 5806 | Cycle 1(1): loaded http://localhost:40163/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40163/tests/kraken/driver.html?testName=audio-beat-detection) 05:11:32 INFO - PROCESS | 5806 | RSS: Main: 170512384 05:11:32 INFO - PROCESS | 5806 | 05:11:35 INFO - PROCESS | 5806 | Cycle 1(1): loaded http://localhost:40163/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40163/tests/kraken/driver.html?testName=audio-dft) 05:11:35 INFO - PROCESS | 5806 | RSS: Main: 174260224 05:11:35 INFO - PROCESS | 5806 | 05:11:38 INFO - PROCESS | 5806 | Cycle 1(1): loaded http://localhost:40163/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40163/tests/kraken/driver.html?testName=audio-fft) 05:11:39 INFO - PROCESS | 5806 | RSS: Main: 164601856 05:11:39 INFO - PROCESS | 5806 | 05:11:41 INFO - PROCESS | 5806 | Cycle 1(1): loaded http://localhost:40163/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40163/tests/kraken/driver.html?testName=audio-oscillator) 05:11:42 INFO - PROCESS | 5806 | RSS: Main: 165142528 05:11:42 INFO - PROCESS | 5806 | 05:11:44 INFO - PROCESS | 5806 | Cycle 1(1): loaded http://localhost:40163/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40163/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:11:45 INFO - PROCESS | 5806 | RSS: Main: 166359040 05:11:45 INFO - PROCESS | 5806 | 05:11:48 INFO - PROCESS | 5806 | Cycle 1(1): loaded http://localhost:40163/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40163/tests/kraken/driver.html?testName=imaging-darkroom) 05:11:48 INFO - PROCESS | 5806 | RSS: Main: 166363136 05:11:48 INFO - PROCESS | 5806 | 05:11:52 INFO - PROCESS | 5806 | Cycle 1(1): loaded http://localhost:40163/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40163/tests/kraken/driver.html?testName=imaging-desaturate) 05:11:53 INFO - PROCESS | 5806 | RSS: Main: 166109184 05:11:53 INFO - PROCESS | 5806 | 05:11:55 INFO - PROCESS | 5806 | Cycle 1(1): loaded http://localhost:40163/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40163/tests/kraken/driver.html?testName=json-parse-financial) 05:11:56 INFO - PROCESS | 5806 | RSS: Main: 166727680 05:11:56 INFO - PROCESS | 5806 | 05:11:58 INFO - PROCESS | 5806 | Cycle 1(1): loaded http://localhost:40163/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40163/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:11:58 INFO - PROCESS | 5806 | RSS: Main: 167534592 05:11:58 INFO - PROCESS | 5806 | 05:12:00 INFO - PROCESS | 5806 | Cycle 1(1): loaded http://localhost:40163/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40163/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:12:01 INFO - PROCESS | 5806 | RSS: Main: 167489536 05:12:01 INFO - PROCESS | 5806 | 05:12:03 INFO - PROCESS | 5806 | Cycle 1(1): loaded http://localhost:40163/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40163/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:12:04 INFO - PROCESS | 5806 | RSS: Main: 167849984 05:12:04 INFO - PROCESS | 5806 | 05:12:07 INFO - PROCESS | 5806 | Cycle 1(1): loaded http://localhost:40163/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:12:07 INFO - PROCESS | 5806 | RSS: Main: 167624704 05:12:07 INFO - PROCESS | 5806 | 05:12:11 INFO - PROCESS | 5806 | Cycle 1(1): loaded http://localhost:40163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:12:11 INFO - PROCESS | 5806 | RSS: Main: 165158912 05:12:11 INFO - PROCESS | 5806 | 05:12:13 INFO - PROCESS | 5806 | Cycle 1(1): loaded http://localhost:40163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40163/tests/kraken/driver.html?testName=ai-astar) 05:12:14 INFO - PROCESS | 5806 | RSS: Main: 167211008 05:12:14 INFO - PROCESS | 5806 | 05:12:14 INFO - PROCESS | 5806 | __start_tp_report 05:12:14 INFO - PROCESS | 5806 | _x_x_mozilla_page_load 05:12:14 INFO - PROCESS | 5806 | _x_x_mozilla_page_load_details 05:12:14 INFO - PROCESS | 5806 | |i|pagename|runs| 05:12:14 INFO - PROCESS | 5806 | |0;ai-astar;116;111;117;113;115;126;114;114;113;113 05:12:14 INFO - PROCESS | 5806 | |1;audio-beat-detection;163;133;159;178;135;166;160;135;189;132 05:12:14 INFO - PROCESS | 5806 | |2;audio-dft;162;164;162;167;167;163;161;163;166;162 05:12:14 INFO - PROCESS | 5806 | |3;audio-fft;77;74;75;158;75;75;74;78;168;76 05:12:14 INFO - PROCESS | 5806 | |4;audio-oscillator;94;95;154;94;95;94;154;95;93;141 05:12:14 INFO - PROCESS | 5806 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;118;119;117 05:12:14 INFO - PROCESS | 5806 | |6;imaging-darkroom;146;147;150;147;148;148;147;147;148;146 05:12:14 INFO - PROCESS | 5806 | |7;imaging-desaturate;96;96;98;96;95;95;96;95;95;95 05:12:14 INFO - PROCESS | 5806 | |8;json-parse-financial;65;65;65;65;64;65;66;82;63;64 05:12:14 INFO - PROCESS | 5806 | |9;json-stringify-tinderbox;64;65;65;65;65;65;65;64;65;65 05:12:14 INFO - PROCESS | 5806 | |10;stanford-crypto-aes;80;78;80;89;83;80;81;81;81;81 05:12:14 INFO - PROCESS | 5806 | |11;stanford-crypto-ccm;135;145;144;143;134;135;149;139;177;143 05:12:14 INFO - PROCESS | 5806 | |12;stanford-crypto-pbkdf2;229;217;217;216;220;214;225;220;225;224 05:12:14 INFO - PROCESS | 5806 | |13;stanford-crypto-sha256-iterative;73;78;78;79;79;74;75;77;74;76 05:12:14 INFO - PROCESS | 5806 | __end_tp_report 05:12:14 INFO - PROCESS | 5806 | __start_cc_report 05:12:14 INFO - PROCESS | 5806 | _x_x_mozilla_cycle_collect,919 05:12:14 INFO - PROCESS | 5806 | __end_cc_report 05:12:14 INFO - PROCESS | 5806 | __startTimestamp1461845533999__endTimestamp 05:12:14 INFO - PROCESS | 5806 | 05:12:14 INFO - PROCESS | 5806 | ------- Summary: start ------- 05:12:14 INFO - PROCESS | 5806 | Number of tests: 14 05:12:14 INFO - PROCESS | 5806 | 05:12:14 INFO - PROCESS | 5806 | [#0] ai-astar Cycles:10 Average:115.20 Median:114.50 stddev:4.16 (3.6%) stddev-sans-first:4.40 05:12:14 INFO - PROCESS | 5806 | Values: 116.0 111.0 117.0 113.0 115.0 126.0 114.0 114.0 113.0 113.0 05:12:14 INFO - PROCESS | 5806 | 05:12:14 INFO - PROCESS | 5806 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:161.50 stddev:20.34 (12.6%) stddev-sans-first:21.37 05:12:14 INFO - PROCESS | 5806 | Values: 163.0 133.0 159.0 178.0 135.0 166.0 160.0 135.0 189.0 132.0 05:12:14 INFO - PROCESS | 5806 | 05:12:14 INFO - PROCESS | 5806 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.21 (1.4%) stddev-sans-first:2.26 05:12:14 INFO - PROCESS | 5806 | Values: 162.0 164.0 162.0 167.0 167.0 163.0 161.0 163.0 166.0 162.0 05:12:14 INFO - PROCESS | 5806 | 05:12:14 INFO - PROCESS | 5806 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.00 stddev:36.99 (49.3%) stddev-sans-first:38.78 05:12:14 INFO - PROCESS | 5806 | Values: 77.0 74.0 75.0 158.0 75.0 75.0 74.0 78.0 168.0 76.0 05:12:14 INFO - PROCESS | 5806 | 05:12:14 INFO - PROCESS | 5806 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:94.00 stddev:26.99 (28.7%) stddev-sans-first:27.93 05:12:14 INFO - PROCESS | 5806 | Values: 94.0 95.0 154.0 94.0 95.0 94.0 154.0 95.0 93.0 141.0 05:12:14 INFO - PROCESS | 5806 | 05:12:14 INFO - PROCESS | 5806 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 05:12:14 INFO - PROCESS | 5806 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 119.0 117.0 05:12:14 INFO - PROCESS | 5806 | 05:12:14 INFO - PROCESS | 5806 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:1.17 (0.8%) stddev-sans-first:1.13 05:12:14 INFO - PROCESS | 5806 | Values: 146.0 147.0 150.0 147.0 148.0 148.0 147.0 147.0 148.0 146.0 05:12:14 INFO - PROCESS | 5806 | 05:12:14 INFO - PROCESS | 5806 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:1.00 05:12:14 INFO - PROCESS | 5806 | Values: 96.0 96.0 98.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 05:12:14 INFO - PROCESS | 5806 | 05:12:14 INFO - PROCESS | 5806 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:65.00 stddev:5.54 (8.5%) stddev-sans-first:5.85 05:12:14 INFO - PROCESS | 5806 | Values: 65.0 65.0 65.0 65.0 64.0 65.0 66.0 82.0 63.0 64.0 05:12:14 INFO - PROCESS | 5806 | 05:12:14 INFO - PROCESS | 5806 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 05:12:14 INFO - PROCESS | 5806 | Values: 64.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 05:12:14 INFO - PROCESS | 5806 | 05:12:14 INFO - PROCESS | 5806 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.00 stddev:2.95 (3.6%) stddev-sans-first:3.09 05:12:14 INFO - PROCESS | 5806 | Values: 80.0 78.0 80.0 89.0 83.0 80.0 81.0 81.0 81.0 81.0 05:12:14 INFO - PROCESS | 5806 | 05:12:14 INFO - PROCESS | 5806 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:143.50 stddev:12.48 (8.7%) stddev-sans-first:12.77 05:12:14 INFO - PROCESS | 5806 | Values: 135.0 145.0 144.0 143.0 134.0 135.0 149.0 139.0 177.0 143.0 05:12:14 INFO - PROCESS | 5806 | 05:12:14 INFO - PROCESS | 5806 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:220.70 Median:222.00 stddev:4.85 (2.2%) stddev-sans-first:4.12 05:12:14 INFO - PROCESS | 5806 | Values: 229.0 217.0 217.0 216.0 220.0 214.0 225.0 220.0 225.0 224.0 05:12:14 INFO - PROCESS | 5806 | 05:12:14 INFO - PROCESS | 5806 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.30 Median:77.50 stddev:2.21 (2.9%) stddev-sans-first:2.00 05:12:14 INFO - PROCESS | 5806 | Values: 73.0 78.0 78.0 79.0 79.0 74.0 75.0 77.0 74.0 76.0 05:12:14 INFO - PROCESS | 5806 | -------- Summary: end -------- 05:12:14 INFO - PROCESS | 5806 | 05:12:14 INFO - TEST-INFO | 5806: exit 0 05:12:15 INFO - TEST-OK | kraken | took 64594ms 05:12:15 INFO - SUITE-END | took 1180s 05:12:15 INFO - Completed test suite (00:19:41) 05:12:15 INFO - javascript benchmark 05:12:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2661.7205193454683, 2719.415325704973, 2748.917532474024, 2758.9724102758964, 2761.351082495612, 4794.208955522335, 4848.854534363971, 4858.1983972644475, 4872.2448020556785, 4918.557329840313, 4750.714957102577, 4794.616430685545, 4854.6844455110395, 4895.730734809584, 4906.950930490703, 4430.158269928711, 4475.28395456727, 4522.027764030733, 4524.163029839474, 4568.1548913451115, 623.790829472408, 4230.74615523068, 4338.739675619458, 4387.605115539601, 4439.866803995886, 4386.078923426085, 4401.185780630593, 4408.581184787472, 4414.161309351245, 4439.089986552749, 4391.538888416734, 4398.780060996937, 4437.711548749321, 4461.24158892989, 4476.194285028693, 4292.957070429318, 4377.715448495837, 4390.62679672225, 4419.226635338835, 4457.064016556527, 4637.281221410687, 4655.0, 4684.437867455893, 4688.531146885318, 4750.809967601292, 5118.07874582575, 5124.205748109011, 5127.359080114986, 5129.256257842592, 5174.016936781999, 5222.529972302473, 5231.0, 5238.607104467142, 5250.343707036621, 5290.788368465257, 4855.0584285622235, 4855.732934688591, 4858.3441235432765, 4859.07677541266, 4871.658983871095, 5142.948570514322, 5169.53474187325, 5263.236830659533, 5344.5724342052545, 5348.171033489815, 5114.820981265712, 5125.410577783603, 5131.5638170755155, 5140.408852981955, 5164.2770012198325, 5216.739163041909, 5231.875146843371, 5232.2413250078525, 5242.659227150223, 5288.444713305124, 4949.133901567211, 5133.486651334837, 5164.9741751291, 5192.117340052125, 5197.610179236573, 5122.641415100908, 5129.435762066169, 5145.382554093533, 5149.45930677281, 5153.2270159476375, 3996.1208534122447, 4018.176273863851, 4019.83920643171, 4022.879313620596, 4048.4939382577177, 3434.4504879219703, 3520.753547251719, 3571.589267234301, 3599.1721903962234, 3627.038834708804, 4438.667099967451, 4512.842050528216, 4542.227821270392, 4561.0, 4587.449506059227, 5188.0, 5202.479752024768, 5205.9219111713355, 5214.45248248936, 5251.789928402897, 4414.55854414556, 4503.752293623882, 4549.067441174551, 4553.430821147356, 4573.81704731807, 4635.745034023161, 4652.325412815123, 4676.976615116971, 4683.7892294846815, 4719.905601887943, 4887.169181239198, 4909.26361045846, 4948.826791062295, 4959.90080198394, 5002.499750024968, 5005.574526165171, 5141.691498510101, 5183.792648294026, 5227.89544209106, 5236.528712415901, 4895.216765317532, 4903.411590609007, 4944.75276236194, 4948.035133149001, 5011.072951503984, 4937.185364414831, 5060.114479966065, 5122.052420302256, 5130.204818253177, 5130.333056702605, 5197.584193264605, 5199.168133098686, 5201.713905735221, 5201.973990130025, 5260.473952604862, 4998.950010499994, 5018.799248030038, 5044.646874718881, 5046.571041461517, 5074.416442109057, 4853.174960256835, 4968.900621987612, 4979.203327467588, 4985.4266759323145, 4992.950070499249, 4926.088673595396, 4946.4558898521855, 4995.450500445021, 5002.699838009731, 5026.3214466048075, 5085.237214417719, 5088.389393272831, 5104.642675012862, 5105.566026887756, 5166.225066240094, 4793.784279707491, 4930.7534623267975, 4933.6432481068, 4937.259411088222, 4939.259111133359], "value": 4699.957809478747, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.1847530318691, 583.8832233553289, 597.9625350017718, 607.1894021481321, 637.3212528656977, 30976.845115774417, 31763.841180794065, 31903.36193276133, 31935.680643193562, 32012.83993580032, 32079.67920320796, 32845.83577082117, 33002.66997330026, 33055.504167437444, 33121.50317745236, 7501.924980750177, 7637.847243055136, 7686.846263074735, 7691.42314326425, 7712.730054448096, 7572.129205141397, 7836.255555722198, 7840.764777056697, 7848.803779905491, 7876.212378762107, 7807.102183248914, 7869.606519674022, 7883.2510911463605, 7896.249856263675, 7900.170482099383, 7802.8439431211345, 7830.29527342539, 7856.882146767803, 7890.9605451972375, 7894.881576776324, 7702.614869256515, 7811.062672479282, 7811.140774514799, 7815.804604884866, 7825.256600622932, 24599.63100553493, 33394.49908251378, 33495.162620934425, 33676.831615841766, 33786.83106584476, 2916.8833246670106, 3035.362573859492, 3059.969400305991, 3408.6761757632985, 3420.846061927219, 26010.86994565034, 26045.0, 26065.08772192983, 26311.342216444744, 26427.207183784325, 3301.1747063234193, 3409.829508524564, 3460.4290292101773, 3462.480627905809, 3464.9133771655656, 161261.0, 164343.0, 164702.176489118, 165622.0, 165959.1702041494, 53980.0, 54724.0748332652, 54751.0, 54803.451965479835, 54808.72595636996, 51445.0, 52262.0, 52483.0, 52543.211851822256, 52632.0, 14791.408343666348, 14796.70406591862, 14818.184999825113, 14932.402703891723, 14966.326515306837, 11348.886511134948, 11397.829032564518, 11478.19652624325, 11481.655550333504, 11544.422778861192, 17211.827881721274, 17307.480775576754, 17450.301987920342, 17503.73744393835, 18214.36249731253, 7128.893066604005, 7409.444291678145, 7449.627518624047, 7463.0, 7488.812779680443, 865.5845194306768, 914.6021480655936, 977.1791694976254, 982.4547376206132, 1009.8384258518602, 25850.870745646152, 26375.47249055008, 26797.732022679913, 27233.45533089327, 27403.588946165823, 929.3123088914155, 989.5992123190119, 1005.8642083318658, 1028.6142696488816, 1039.8544203811473, 14207.147571145764, 14349.35427905726, 14372.568822935329, 14427.3507692152, 14429.20639364845, 200295.0, 205991.0, 206449.0, 207950.0, 207951.0, 44934.0, 45542.77228613836, 45642.08715825665, 45898.0, 46037.7698111514, 1282.4421376701164, 1284.3321472834075, 1289.8387701537308, 1292.5669900583223, 1318.5780550223835, 25677.229683109537, 26583.867080665248, 26672.733272667025, 26767.330816729736, 27531.724682753716, 39679.801600991814, 40471.392929106674, 40481.797591011855, 40520.18959620732, 40525.39211911765, 213715.0, 214728.0, 215195.0, 215550.0, 215755.0, 23932.162374316817, 24093.277201683977, 24314.878425608465, 24370.75629243756, 24635.260942171764, 37126.0, 37843.0, 37989.24021519609, 38153.80923095478, 38377.80811096038, 32544.51183232206, 32816.835915820266, 32933.200677941684, 33435.0, 33448.1637959053, 32470.837645811618, 32517.34965300728, 32646.34707305888, 33129.337413251116, 33328.1667958303, 26237.34406639849, 29370.412591748474, 29965.101046968626, 31981.0, 32215.838920805247, 28477.857610711813, 28898.27754306159, 29283.267918302212, 29464.410711785215, 29754.702452975194, 22908.4272893179, 23384.372438883493, 23613.409664758517, 23777.167799126946, 23797.881010594836], "value": 16201.967648801836, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.2024918543208, 387.38986096897384, 390.81534713164183, 392.91159489114955, 402.67785771382887, 12274.447649855756, 14882.330295136719, 14937.17845518496, 15434.536963891072, 15592.45426410076, 14658.63353416165, 14902.40390384386, 15153.24233788309, 16612.750808737877, 16648.33406663732, 4935.802567897289, 5004.8238663914135, 5156.226566015109, 5159.484051594848, 5181.0933086709865, 5054.0, 5105.0, 5127.487251274862, 5131.820386286481, 5142.768575414116, 5074.238864170386, 5081.949180508184, 5092.236164575306, 5095.770690318926, 5102.872428189288, 4825.662203645747, 5001.499850014988, 5016.774245158977, 5022.84931452057, 5046.09170349337, 4479.7984090716, 4495.730256184606, 4504.1892459357305, 4532.229520981441, 4536.9791796845775, 17156.399526016656, 18315.175817088264, 19315.4205373839, 19469.0, 19534.90232548828, 1849.4174335084406, 1901.7337572739827, 2054.41449186981, 2364.5034542746043, 2474.9357776156244, 8720.0, 9100.908990910073, 9134.543272836332, 11457.36984465854, 12035.57875474363, 1641.1794102948527, 1712.7773389459414, 1743.921523531444, 1754.1843042985074, 1800.2349001674368, 59869.70065149647, 60197.0, 60506.394936050514, 60874.0, 60992.695036524536, 9319.301052421095, 9710.563024663907, 9762.36544624597, 9975.501224938724, 10324.741881452874, 12083.758324833454, 12766.61700148997, 13850.65373365674, 13919.582412527641, 13961.115249441398, 6876.759313424006, 7031.367176953996, 7130.393916517154, 7219.133703955559, 7229.89155162673, 6686.063951046857, 6695.899561506581, 6700.0, 6821.283765204681, 6891.552049116792, 4276.615104640598, 4356.586124318184, 4387.868363949086, 4437.511873693891, 4456.24243878535, 1807.9005654689117, 1864.3567969050655, 1889.7921228664836, 1929.6816025355658, 1947.7662680478434, 793.4287313134533, 884.6903583745766, 904.69692652962, 927.4806108579218, 937.4562753602894, 14789.186594737177, 15615.921920390325, 15671.921640391725, 15934.92032539853, 16519.174041297887, 879.9340049496313, 891.1712107739864, 896.1397058823472, 903.5888670654837, 909.2634965677822, 9320.8601870972, 9342.982801301023, 9355.625774969061, 9382.67160649374, 9447.149756521809, 362275.0, 363540.0, 364260.0, 365177.0, 372336.0, 63616.0, 64110.679446602466, 64175.35824641787, 64665.35334646687, 67805.32194678088, 909.9636014559344, 917.6283605139796, 929.3773171974793, 944.3436811416137, 950.6577632052456, 14345.64135896611, 14351.349594796731, 14427.134371937716, 14438.494652687106, 14595.0, 23030.769692302863, 32151.196220094684, 32319.0, 32349.191270218435, 32500.187495312806, 42168.1566368677, 42486.36270456007, 43136.568634313255, 43360.783196083816, 43689.56310436855, 7639.923600764144, 7773.805654858674, 7783.260590243918, 7791.805204869697, 7851.528908265523, 10247.411651194077, 11104.222704410613, 11387.487563059516, 11524.884751152382, 11546.94226528862, 9808.117269445784, 9945.850812237677, 10083.193344532274, 10117.544710488193, 10169.389836609827, 10221.131203847755, 10277.126444252322, 10334.844977325196, 10403.0, 10518.737031574272, 10030.147437467896, 10047.0, 10120.746981325527, 10170.338927969658, 10191.643292484727, 7565.356944659546, 7624.504407213735, 7662.6934922604705, 7682.7311044113185, 7964.362850971793, 7707.884381734167, 9987.550560224661, 10302.690919272434, 10373.222008349554, 10570.41862697559], "value": 7889.09553646543, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1425.672095418054, 1439.352291468839, 1577.148339896456, 1710.4783041172439, 1737.0012242960292, 6644.900326495094, 7229.891551626723, 7356.816079598013, 7551.471397002212, 7587.317141457274, 7431.628418579063, 7486.775396738093, 7523.887141692879, 7524.946507488956, 7537.359324457414, 2226.0428015953134, 2241.8094461970754, 2261.0616594113503, 2261.4459457432954, 2262.366537369539, 2217.7227846519186, 2237.2393386248673, 2255.4925141843037, 2256.26671331817, 2267.1384873748034, 2214.357836227492, 2227.3095340444515, 2238.8656680599133, 2244.9438764030947, 2249.5500899820017, 2187.595294870454, 2203.5813195492806, 2210.1159536185573, 2211.281333566589, 2212.303124515772, 2177.6298029335053, 2190.8028277455105, 2196.2313190383397, 2209.4807720185745, 2213.7786221377896, 7634.312911837961, 7649.655765490566, 7676.347510461562, 7676.80807979805, 7679.654415551314, 4585.79363928624, 4796.664233503621, 4814.7833347499445, 4820.0, 4850.029994001214, 2860.7711383089304, 3061.2959019425434, 3066.0801759472292, 3097.287623846528, 3101.069679096262, 933.1275257634067, 943.3820847344931, 948.7106432538073, 976.8681228034267, 1018.3889666200295, 10163.034511721375, 10196.0, 10197.694069177862, 10204.0, 10222.642207522775, 4248.8300467980935, 4305.375720520507, 4339.956600434019, 4375.912481750347, 4375.912481750347, 8734.213920747163, 8780.42927209742, 8793.824123517494, 8841.734747957571, 8849.247813935888, 4718.0, 4773.307870358848, 4775.379200703886, 4778.092162489116, 4805.471398146201, 3751.4935483709896, 4203.747775133502, 4240.978795106004, 4319.43847299849, 4384.145091707086, 3615.8011309378235, 3666.7616604920595, 3721.4603882436895, 3753.9249215016093, 3781.1303400218103, 1252.1547955130434, 1276.1003492537739, 1282.4805953588811, 1289.8323217981601, 1298.8571257161705, 732.5055587478431, 759.236966848314, 795.9044914610168, 843.9535825529655, 911.7401540560908, 4874.5856602188505, 4914.606831453475, 4993.700377977333, 5128.871778205575, 5594.664320140804, 902.4585248850638, 954.7947191353892, 955.2405837359316, 958.9089036541517, 964.1226483899618, 3587.8385472653795, 3612.2414292998237, 3724.8696295630066, 3745.194783121642, 3807.8857634271017, 8918.331125165638, 9207.76980575491, 9294.977552469223, 9364.906350936404, 9393.107654772786, 9029.729108126767, 9138.360314778034, 9150.130737579919, 9288.024757400512, 9307.3019523536, 7056.400205982549, 7153.427725781925, 7195.89206161908, 7231.385332246818, 7275.4179665626625, 5206.479352064764, 5210.348706411699, 5243.528082472596, 5255.684658920324, 5308.893822123613, 8305.83388332242, 8590.527520986405, 8752.256058235122, 8775.210231079234, 8856.424332418372, 8725.0, 8736.432131911406, 8770.824583508422, 8794.076621954602, 8900.287976961958, 5737.9139312911175, 6110.114033465212, 6297.023961286008, 6334.398232167937, 6351.587146835441, 7183.066201393785, 7190.460715446257, 7236.4210863131875, 7243.058402407864, 7264.527805692613, 6400.583962042452, 6575.2767195607485, 6597.967010164918, 6694.062831203538, 6696.296888826798, 6263.09185168139, 6297.0, 6343.9682801585695, 6369.649669268235, 6379.170707807955, 6205.286392064971, 6348.365163483615, 6353.841153971188, 6362.427381535684, 6413.871722565429, 4431.3352997049415, 4607.101615185007, 4622.768861556841, 4676.158291507425, 4696.483386827378, 4420.955790442054, 4512.368268442355, 4562.794674239601, 4615.26155815068, 4638.211504044253], "value": 4138.805883761978, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.81411524854593, 303.6235068515041, 306.3887544349024, 307.9645840728317, 311.6307175996443, 4930.778114984825, 4967.552920237178, 4991.700497970124, 4997.900041999158, 5006.474320196382, 4868.318435419044, 4875.756212189394, 4887.608991280698, 4895.11887860185, 4905.362302900627, 3682.3555877721424, 3794.392897136459, 3863.98068009661, 3903.6486716195536, 3914.725969182158, 3876.263509933118, 3892.4355968384566, 3902.7072969527258, 3904.9804750976205, 3946.940795888064, 3879.7478163919395, 3890.1636148228126, 3893.415987601854, 3900.668443182333, 3904.4533765272886, 3797.6012518685693, 3884.961150388502, 3886.455896174524, 3899.161680238734, 3914.3149948758855, 3427.9143021424416, 3452.3440546296124, 3452.912332615218, 3453.568303962005, 3461.446168613035, 4718.386609740712, 4725.291206319045, 4730.148573256813, 4733.526647335273, 4760.238361862085, 4394.868153955386, 4426.3581780641625, 4430.712003719748, 4445.310392374322, 4449.688521803475, 4931.112399768041, 5153.685810118396, 5154.355705536808, 5156.974215128937, 5211.557017653504, 3591.8024508652015, 3613.313470440608, 3627.9818600907092, 3635.800030998294, 3644.0889777555612, 5360.865978350534, 5371.113766228567, 5386.542143917733, 5425.131978883399, 5448.727563621803, 3629.91280013993, 3642.8724994625063, 3727.813609319523, 3739.2521495700967, 3747.737658363943, 3774.169682669808, 3781.829817658212, 3795.7342985990717, 3804.4483549885113, 3809.1810260794064, 4315.762633055149, 4316.7409955402145, 4346.695731298779, 4351.804168812411, 4372.409724687126, 5029.647924645313, 5159.703931750335, 5174.611904107207, 5184.766685499161, 5204.843854684365, 1360.6190266725332, 1378.6415531961761, 1378.8552202018843, 1379.6895698467765, 1380.7997840313099, 846.4540371460373, 894.0, 894.7763059235191, 912.3476714149415, 912.8174365127002, 4548.0, 4644.187267228222, 4647.86056418308, 4650.348951146842, 4681.204195286809, 5311.7344132793205, 5317.946820531745, 5350.812721554805, 5358.258565965999, 5358.517733404013, 4524.25349817283, 4602.792874320664, 4620.768961551909, 4641.698289611165, 4643.512431194744, 3034.4689679306034, 3041.4373340931556, 3049.283418396675, 3063.417950589381, 3092.5515800209296, 5414.91877621836, 5422.728863556807, 5441.918371224435, 5466.644668096561, 5477.780888764484, 5665.5467562594895, 5875.206847075676, 5885.323187833454, 5887.911681324784, 5892.234009578728, 5457.317835270591, 5466.316710411199, 5473.38535132137, 5485.232067510552, 5494.2857428535635, 5721.942780572141, 5723.599348045597, 5736.168255602997, 5746.304840072105, 5749.0, 5004.4495105537635, 5288.2860813791185, 5307.681539107666, 5316.2823018893505, 5355.169948657965, 5146.871328216825, 5153.3043039190725, 5170.793168273227, 5173.948260517347, 5187.1181899078, 3716.7026637869444, 3747.632114278323, 3760.9059773505883, 3774.7923864186637, 3780.4896338993885, 5160.354955630546, 5325.653832500875, 5350.652207606493, 5369.0872551665525, 5377.897531006212, 5166.8966620668125, 5197.8440646780655, 5207.6875387476875, 5212.322398088224, 5245.6852588844795, 5010.599152067899, 5172.301739265151, 5181.1969144782615, 5206.349206349207, 5206.73966301691, 5122.206058061007, 5122.718250496258, 5160.793568257378, 5168.560672342893, 5170.0, 4942.5304596063315, 5048.8990220194655, 5207.0, 5267.552258058108, 5270.578353731616, 5045.899082018265, 5090.694558326512, 5115.104856649997, 5117.618243074424, 5135.0], "value": 3957.5762853849715, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.627039452315, 675.5507587454343, 768.8539177556264, 783.4672422752533, 799.5842162075725, 11815.822762658556, 12146.69633259169, 12177.634670959875, 12231.510739570407, 12236.20464669796, 11077.50151243194, 11106.27809192402, 11150.442477876115, 11321.377324247163, 11323.660290191307, 636.8853606350855, 789.3882241263038, 789.3921680306175, 813.0527934955769, 813.9023317201915, 811.8213992921577, 816.5753808019826, 817.3461231015194, 817.4686453805044, 817.840521098386, 850.1073872433919, 852.5779739029189, 854.0306751836679, 854.3592305770673, 854.3976496569903, 846.7713717296357, 846.8391005708895, 849.3247867944998, 849.9235068843802, 851.5231470376609, 615.2186722861941, 616.214326733414, 619.5105866365566, 619.9690015499207, 622.794477822322, 12323.753524929542, 12344.321062341567, 12383.071269654722, 12392.876071239352, 12446.688832779162, 12692.873071269261, 12881.098323117385, 12935.288559129243, 12983.805242921364, 13022.413991370317, 9984.25118116137, 9993.900060999369, 10069.043440873105, 10130.696079117639, 10145.847812282822, 3339.7662163648556, 3426.468897320919, 3439.8108104054268, 3515.4726790981304, 3547.130952916526, 44128.11743765107, 44445.77777111094, 44602.77698611518, 45605.543944560464, 46294.537054629356, 10274.280800343904, 10283.9485802572, 10320.380777153396, 10333.586656533806, 10604.416757078434, 17711.557211069827, 17755.73366399505, 17785.644287114184, 17844.9107754463, 17955.910220449074, 6755.4257888080065, 7027.964860175666, 7069.116360454943, 7088.610126443095, 7111.679974401164, 3805.6955443564448, 3836.3286424875537, 3856.8842934712, 3898.5126859142606, 3907.1404291055924, 2847.288177955511, 2893.3923875985856, 2893.7540309073543, 2907.636545431821, 2917.693642167584, 498.7930009046205, 517.1802692731986, 525.6609486881017, 529.1110933631536, 532.5287120897956, 488.11650911849665, 562.2887047884429, 576.9451902069296, 589.3311091910713, 596.931352894414, 7511.774646760606, 7571.0, 7836.960815195887, 7946.086200086948, 7997.960010200029, 441.36002795946007, 459.1001636791925, 504.70222568684653, 532.934131736527, 574.3538519165938, 3927.9803600981813, 4084.162746636992, 4136.193442278787, 4190.161967606491, 4360.65114790816, 55808.441915580326, 56564.15153772697, 56984.715076424356, 58001.4199857996, 58495.70752146297, 51033.234501482504, 51270.0, 51477.0, 51991.22013169806, 54201.72899135558, 46004.76997614923, 46440.767796160806, 46585.5341446588, 47106.293405598946, 47497.28754068692, 8420.621072051896, 8450.704225352083, 8551.35864810154, 8698.865452221167, 8817.25053370445, 27711.58432623472, 28687.282817929718, 29049.12852614425, 30691.386172275983, 30882.382352353277, 38889.6111038886, 38898.0, 39123.0, 39504.60495395009, 39583.2083358337, 10457.320274182153, 10582.682519524427, 10584.89415105839, 10638.255322127377, 10650.73373165677, 11435.714107147054, 11510.30938143714, 11807.409629518317, 12067.155299129328, 12971.221726696429, 11389.544418223179, 11797.469113890067, 11843.220973035262, 11856.525738970344, 12095.637130886087, 10715.035646791826, 10918.836217456586, 10939.0, 11304.49129789145, 11462.770744585228, 11695.941520292345, 11699.356535390636, 11764.764704706029, 12150.088743344108, 12183.695407614881, 9590.03447008469, 9613.759656008655, 9637.18083962871, 9734.951325243328, 10203.438810865473, 9587.904120958701, 10245.0, 10260.023184234791, 10348.637797677346, 10471.267011309135], "value": 6038.915147005028, "unit": "score"}], "name": "dromaeo_css", "value": 6246.920606960968, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 117.0, 113.0, 115.0, 126.0, 114.0, 114.0, 113.0, 113.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 133.0, 159.0, 178.0, 135.0, 166.0, 160.0, 135.0, 189.0, 132.0], "value": 155.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 167.0, 167.0, 163.0, 161.0, 163.0, 166.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 75.0, 158.0, 75.0, 75.0, 74.0, 78.0, 168.0, 76.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 154.0, 94.0, 95.0, 94.0, 154.0, 95.0, 93.0, 141.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 119.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 150.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 98.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 66.0, 82.0, 63.0, 64.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 80.0, 89.0, 83.0, 80.0, 81.0, 81.0, 81.0, 81.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 145.0, 144.0, 143.0, 134.0, 135.0, 149.0, 139.0, 177.0, 143.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [229.0, 217.0, 217.0, 216.0, 220.0, 214.0, 225.0, 220.0, 225.0, 224.0], "value": 220.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 78.0, 79.0, 79.0, 74.0, 75.0, 77.0, 74.0, 76.0], "value": 76.3, "unit": "score"}], "name": "kraken", "value": 1652.3000000000002, "alertThreshold": 2.0}]} 05:12:15 INFO - Return code: 0 05:12:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:12:15 ERROR - # TBPL SUCCESS # 05:12:15 INFO - Running post-action listener: _resource_record_post_action 05:12:15 INFO - Running post-run listener: _resource_record_post_run 05:12:16 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 495616; Write bytes: 301699072; Read time: 24; Write time: 230520 05:12:16 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 8175616; Read time: 0; Write time: 1056 05:12:16 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 495616; Write bytes: 293523456; Read time: 24; Write time: 229464 05:12:16 INFO - Running post-run listener: _upload_blobber_files 05:12:16 INFO - Blob upload gear active. 05:12:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:12:16 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:12:16 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:12:16 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:12:16 INFO - (blobuploader) - INFO - Open directory for files ... 05:12:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:12:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:12:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:17 INFO - (blobuploader) - INFO - Done attempting. 05:12:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:12:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:12:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:18 INFO - (blobuploader) - INFO - Done attempting. 05:12:18 INFO - (blobuploader) - INFO - Iteration through files over. 05:12:18 INFO - Return code: 0 05:12:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:12:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:12:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0a6ab61735382e5c66f1d2dfd929e229b6c70df1e3e1afb24c8f67db3fe881d02e445f3c613f59b91eab89c9e8f231195833dbb1d70cd968fea13d1a1ad3c86", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20b2e1a982afdf2e4b7fa9fe5002e2e0f8ab4344f51e128924779ac68be02d1e9d6d64b4b3cdcd9e45dadbdd30d040d0f8aad60383fb4708ef6d0fd2dedb191c"} 05:12:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:12:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:12:18 INFO - Contents: 05:12:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0a6ab61735382e5c66f1d2dfd929e229b6c70df1e3e1afb24c8f67db3fe881d02e445f3c613f59b91eab89c9e8f231195833dbb1d70cd968fea13d1a1ad3c86", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20b2e1a982afdf2e4b7fa9fe5002e2e0f8ab4344f51e128924779ac68be02d1e9d6d64b4b3cdcd9e45dadbdd30d040d0f8aad60383fb4708ef6d0fd2dedb191c"} 05:12:18 INFO - Running post-run listener: copy_logs_to_upload_dir 05:12:18 INFO - Copying logs to upload dir... 05:12:18 INFO - mkdir: /builds/slave/test/build/upload/logs 05:12:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.771152 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-28 05:12:18.418855) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:18.422452) ========= 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=d2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0a6ab61735382e5c66f1d2dfd929e229b6c70df1e3e1afb24c8f67db3fe881d02e445f3c613f59b91eab89c9e8f231195833dbb1d70cd968fea13d1a1ad3c86", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20b2e1a982afdf2e4b7fa9fe5002e2e0f8ab4344f51e128924779ac68be02d1e9d6d64b4b3cdcd9e45dadbdd30d040d0f8aad60383fb4708ef6d0fd2dedb191c"} build_url:https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/BIdHtpy0SiSl-juUHy_BfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0a6ab61735382e5c66f1d2dfd929e229b6c70df1e3e1afb24c8f67db3fe881d02e445f3c613f59b91eab89c9e8f231195833dbb1d70cd968fea13d1a1ad3c86", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20b2e1a982afdf2e4b7fa9fe5002e2e0f8ab4344f51e128924779ac68be02d1e9d6d64b4b3cdcd9e45dadbdd30d040d0f8aad60383fb4708ef6d0fd2dedb191c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:18.447809) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:18.448163) ========= 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=d2a8c569965ab8367867b893000001a1-1461843540.193873-1307337185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004637 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:12:18.531819) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 05:12:18.532273) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 05:12:18.532744) ========= ========= Total master_lag: 0.16 =========