builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1462544881.34 results: success (0) buildid: 20160506064620 builduid: 48973e8eecc94d9989c2a1ec7b465d6d revision: f97139bf14beb480b3255c69b3e43f376c548e31 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.343377) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.343957) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.344284) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.377713) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.378023) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 07:28:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-05-06 07:28:01 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076160 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.467777) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.468109) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015085 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.528246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.528910) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f97139bf14beb480b3255c69b3e43f376c548e31 --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 f97139bf14beb480b3255c69b3e43f376c548e31 --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=516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 07:28:01,822 truncating revision to first 12 chars 2016-05-06 07:28:01,822 Setting DEBUG logging. 2016-05-06 07:28:01,822 attempt 1/10 2016-05-06 07:28:01,822 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f97139bf14be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 07:28:02,095 unpacking tar archive at: fx-team-f97139bf14be/testing/mozharness/ program finished with exit code 0 elapsedTime=0.578669 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:02.120965) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:02.121318) ========= script_repo_revision: f97139bf14beb480b3255c69b3e43f376c548e31 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:02.121803) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:02.122131) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:02.131569) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-06 07:28:02.131889) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:28:02 INFO - MultiFileLogger online at 20160506 07:28:02 in /builds/slave/test 07:28:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:28:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:28:02 INFO - {'append_to_log': False, 07:28:02 INFO - 'base_work_dir': '/builds/slave/test', 07:28:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:28:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:28:02 INFO - 'branch': 'Fx-Team-Non-PGO', 07:28:02 INFO - 'buildbot_json_path': 'buildprops.json', 07:28:02 INFO - 'config_files': ('talos/linux_config.py',), 07:28:02 INFO - 'default_actions': ('clobber', 07:28:02 INFO - 'read-buildbot-config', 07:28:02 INFO - 'download-and-extract', 07:28:02 INFO - 'populate-webroot', 07:28:02 INFO - 'create-virtualenv', 07:28:02 INFO - 'install', 07:28:02 INFO - 'run-tests'), 07:28:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:28:02 INFO - 'download_minidump_stackwalk': True, 07:28:02 INFO - 'download_symbols': 'ondemand', 07:28:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:28:02 INFO - 'tooltool.py': '/tools/tooltool.py', 07:28:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:28:02 INFO - '/tools/misc-python/virtualenv.py')}, 07:28:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:28:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:28:02 INFO - 'installer_path': 'installer.exe', 07:28:02 INFO - 'log_level': 'info', 07:28:02 INFO - 'log_name': 'talos', 07:28:02 INFO - 'log_to_console': True, 07:28:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:28:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:28:02 INFO - 'opt_config_files': (), 07:28:02 INFO - 'pip_index': False, 07:28:02 INFO - 'sps_profile': False, 07:28:02 INFO - 'sps_profile_interval': 0, 07:28:02 INFO - 'suite': 'dromaeojs', 07:28:02 INFO - 'system_bits': '32', 07:28:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:28:02 INFO - 'title': 'talos-linux64-ix-061', 07:28:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:28:02 INFO - 'use_talos_json': True, 07:28:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:28:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:28:02 INFO - 'work_dir': 'build'} 07:28:02 INFO - ##### 07:28:02 INFO - ##### Running clobber step. 07:28:02 INFO - ##### 07:28:02 INFO - Running pre-action listener: _resource_record_pre_action 07:28:02 INFO - Running main action method: clobber 07:28:02 INFO - rmtree: /builds/slave/test/build 07:28:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:28:02 INFO - Running post-action listener: _resource_record_post_action 07:28:02 INFO - ##### 07:28:02 INFO - ##### Finished clobber step (success) 07:28:02 INFO - ##### 07:28:02 INFO - ##### 07:28:02 INFO - ##### Running read-buildbot-config step. 07:28:02 INFO - ##### 07:28:02 INFO - Running pre-action listener: _resource_record_pre_action 07:28:02 INFO - Running main action method: read_buildbot_config 07:28:02 INFO - Using buildbot properties: 07:28:02 INFO - { 07:28:02 INFO - "project": "", 07:28:02 INFO - "product": "firefox", 07:28:02 INFO - "script_repo_revision": "production", 07:28:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:28:02 INFO - "repository": "", 07:28:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:28:02 INFO - "buildid": "20160506064620", 07:28:02 INFO - "pgo_build": "False", 07:28:02 INFO - "basedir": "/builds/slave/test", 07:28:02 INFO - "buildnumber": 1733, 07:28:02 INFO - "slavename": "talos-linux64-ix-061", 07:28:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:28:02 INFO - "platform": "ubuntu64_hw", 07:28:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:28:02 INFO - "branch": "fx-team", 07:28:02 INFO - "repo_path": "integration/fx-team", 07:28:02 INFO - "revision": "f97139bf14beb480b3255c69b3e43f376c548e31", 07:28:02 INFO - "stage_platform": "linux64", 07:28:02 INFO - "builduid": "48973e8eecc94d9989c2a1ec7b465d6d", 07:28:02 INFO - "slavebuilddir": "test" 07:28:02 INFO - } 07:28:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:28:02 INFO - Running post-action listener: _resource_record_post_action 07:28:02 INFO - ##### 07:28:02 INFO - ##### Finished read-buildbot-config step (success) 07:28:02 INFO - ##### 07:28:02 INFO - ##### 07:28:02 INFO - ##### Running download-and-extract step. 07:28:02 INFO - ##### 07:28:02 INFO - Running pre-action listener: _resource_record_pre_action 07:28:02 INFO - Running main action method: download_and_extract 07:28:02 INFO - mkdir: /builds/slave/test/build/tests 07:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:02 INFO - https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:28:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:28:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:28:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/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 07:28:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/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 07:28:05 INFO - Downloaded 1361 bytes. 07:28:05 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:28:05 INFO - Using the following test package requirements: 07:28:05 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:05 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:28:05 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:28:05 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:05 INFO - u'jsshell-linux-x86_64.zip'], 07:28:05 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:28:05 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:05 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:28:05 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:28:05 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:28:05 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:28:05 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:28:05 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')]} 07:28:05 INFO - https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:28:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/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 07:28:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/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 07:28:06 INFO - Downloaded 22321395 bytes. 07:28:06 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'] 07:28:06 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 07:28:07 INFO - Return code: 0 07:28:07 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 07:28: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')]} 07:28:07 INFO - https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:28:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/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 07:28:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/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 07:28:09 INFO - Downloaded 22321395 bytes. 07:28:09 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'] 07:28:09 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 07:28:10 INFO - Return code: 0 07:28:10 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')]} 07:28:10 INFO - https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:28:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/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 07:28:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/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 07:28:11 INFO - Downloaded 10840152 bytes. 07:28:11 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'] 07:28:11 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 07:28:12 INFO - Return code: 0 07:28:12 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')]} 07:28:12 INFO - https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:28:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:28:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:28:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/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 07:28:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/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 07:28:13 INFO - Downloaded 54839136 bytes. 07:28:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:28:13 INFO - mkdir: /builds/slave/test/properties 07:28:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:28:13 INFO - Writing to file /builds/slave/test/properties/build_url 07:28:13 INFO - Contents: 07:28:13 INFO - build_url:https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:28:14 INFO - Running post-action listener: _resource_record_post_action 07:28:14 INFO - Running post-action listener: set_extra_try_arguments 07:28:14 INFO - ##### 07:28:14 INFO - ##### Finished download-and-extract step (success) 07:28:14 INFO - ##### 07:28:14 INFO - ##### 07:28:14 INFO - ##### Running populate-webroot step. 07:28:14 INFO - ##### 07:28:14 INFO - Running pre-action listener: _resource_record_pre_action 07:28:14 INFO - Running main action method: populate_webroot 07:28:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:28:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:28:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:28:14 INFO - '--tppagecycles', 07:28:14 INFO - '7'], 07:28:14 INFO - 'tests': ['tsvgm']}}, 07:28:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:28:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:28:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:28:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:28:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:28:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:28:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:14 INFO - 'talos_options': ['--disable-e10s'], 07:28:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:28:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:28:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:14 INFO - 'talos_options': ['--disable-e10s'], 07:28:14 INFO - 'tests': ['damp', 'tps']}, 07:28:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:14 INFO - 'tests': ['damp', 'tps']}, 07:28:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:28:14 INFO - 'tests': ['dromaeo_dom']}, 07:28:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:28:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:28:14 INFO - 'tests': ['a11yr', 07:28:14 INFO - 'ts_paint', 07:28:14 INFO - 'tpaint', 07:28:14 INFO - 'sessionrestore', 07:28:14 INFO - 'sessionrestore_no_auto_restore', 07:28:14 INFO - 'tabpaint']}, 07:28:14 INFO - 'other-e10s': {'tests': ['a11yr', 07:28:14 INFO - 'ts_paint', 07:28:14 INFO - 'tpaint', 07:28:14 INFO - 'sessionrestore', 07:28:14 INFO - 'sessionrestore_no_auto_restore', 07:28:14 INFO - 'tabpaint']}, 07:28:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:28:14 INFO - 'ts_paint', 07:28:14 INFO - 'tpaint', 07:28:14 INFO - 'sessionrestore', 07:28:14 INFO - 'sessionrestore_no_auto_restore', 07:28:14 INFO - 'tabpaint']}, 07:28:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:28:14 INFO - 'ts_paint', 07:28:14 INFO - 'tpaint', 07:28:14 INFO - 'sessionrestore', 07:28:14 INFO - 'sessionrestore_no_auto_restore', 07:28:14 INFO - 'tabpaint']}, 07:28:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:28:14 INFO - 'tests': ['a11yr', 07:28:14 INFO - 'ts_paint', 07:28:14 INFO - 'tpaint', 07:28:14 INFO - 'sessionrestore', 07:28:14 INFO - 'sessionrestore_no_auto_restore', 07:28:14 INFO - 'tabpaint']}, 07:28:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:28:14 INFO - 'tests': ['a11yr', 07:28:14 INFO - 'ts_paint', 07:28:14 INFO - 'tpaint', 07:28:14 INFO - 'sessionrestore', 07:28:14 INFO - 'sessionrestore_no_auto_restore', 07:28:14 INFO - 'tabpaint']}, 07:28:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:28:14 INFO - 'tests': ['tsvgx', 07:28:14 INFO - 'tsvgr_opacity', 07:28:14 INFO - 'tart', 07:28:14 INFO - 'tscrollx', 07:28:14 INFO - 'cart']}, 07:28:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:28:14 INFO - 'tsvgr_opacity', 07:28:14 INFO - 'tart', 07:28:14 INFO - 'tscrollx', 07:28:14 INFO - 'cart']}, 07:28:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:14 INFO - 'talos_options': ['--disable-e10s'], 07:28:14 INFO - 'tests': ['tp5o']}, 07:28:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:14 INFO - 'tests': ['tp5o']}, 07:28:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:14 INFO - 'talos_options': ['--disable-e10s', 07:28:14 INFO - '--xperf_path', 07:28:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:28:14 INFO - 'tests': ['tp5n']}, 07:28:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:14 INFO - 'talos_options': ['--xperf_path', 07:28:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:28:14 INFO - 'tests': ['tp5n']}}, 07:28:14 INFO - 'talos.zip': {'path': '', 07:28:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:28:14 INFO - Running post-action listener: _resource_record_post_action 07:28:14 INFO - ##### 07:28:14 INFO - ##### Finished populate-webroot step (success) 07:28:14 INFO - ##### 07:28:14 INFO - ##### 07:28:14 INFO - ##### Running create-virtualenv step. 07:28:14 INFO - ##### 07:28:14 INFO - Running pre-action listener: _resource_record_pre_action 07:28:14 INFO - Running main action method: create_virtualenv 07:28:14 INFO - Creating virtualenv /builds/slave/test/build/venv 07:28:14 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 07:28:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:28:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:28:14 INFO - Using real prefix '/usr' 07:28:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:28:14 INFO - Installing distribute.............................................................................................................................................................................................done. 07:28:16 INFO - Installing pip.................done. 07:28:16 INFO - Return code: 0 07:28:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe6f38cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1108410>, '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 0x1109310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11097a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', '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 07:28:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:28:16 INFO - Using env: {'DISPLAY': ':0', 07:28:16 INFO - 'HOME': '/home/cltbld', 07:28:16 INFO - 'LANG': 'en_US.UTF-8', 07:28:16 INFO - 'LANGUAGE': 'en_US:en', 07:28:16 INFO - 'LOGNAME': 'cltbld', 07:28:16 INFO - 'MAIL': '/var/mail/cltbld', 07:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:16 INFO - 'MOZ_NO_REMOTE': '1', 07:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:16 INFO - 'NO_EM_RESTART': '1', 07:28:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:16 INFO - 'PWD': '/builds/slave/test', 07:28:16 INFO - 'SHELL': '/bin/bash', 07:28:16 INFO - 'SHLVL': '1', 07:28:16 INFO - 'TERM': 'linux', 07:28:16 INFO - 'TMOUT': '86400', 07:28:16 INFO - 'USER': 'cltbld', 07:28:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', 07:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:16 INFO - '_': '/tools/buildbot/bin/python'} 07:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:16 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 07:28:16 INFO - Cleaning up... 07:28:16 INFO - Return code: 0 07:28:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbe6f38cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1108410>, '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 0x1109310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11097a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', '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 07:28:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:28:16 INFO - Using env: {'DISPLAY': ':0', 07:28:16 INFO - 'HOME': '/home/cltbld', 07:28:16 INFO - 'LANG': 'en_US.UTF-8', 07:28:16 INFO - 'LANGUAGE': 'en_US:en', 07:28:16 INFO - 'LOGNAME': 'cltbld', 07:28:16 INFO - 'MAIL': '/var/mail/cltbld', 07:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:16 INFO - 'MOZ_NO_REMOTE': '1', 07:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:16 INFO - 'NO_EM_RESTART': '1', 07:28:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:16 INFO - 'PWD': '/builds/slave/test', 07:28:16 INFO - 'SHELL': '/bin/bash', 07:28:16 INFO - 'SHLVL': '1', 07:28:16 INFO - 'TERM': 'linux', 07:28:16 INFO - 'TMOUT': '86400', 07:28:16 INFO - 'USER': 'cltbld', 07:28:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', 07:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:16 INFO - '_': '/tools/buildbot/bin/python'} 07:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:17 INFO - Downloading/unpacking psutil>=0.7.1 07:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:28:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:19 INFO - Installing collected packages: psutil 07:28:19 INFO - Running setup.py install for psutil 07:28:19 INFO - building 'psutil._psutil_linux' extension 07:28:19 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 07:28:19 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 07:28:19 INFO - building 'psutil._psutil_posix' extension 07:28:19 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 07:28:19 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 07:28:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:19 INFO - Successfully installed psutil 07:28:19 INFO - Cleaning up... 07:28:19 INFO - Return code: 0 07:28:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:28:19 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')]} 07:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:19 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')]} 07:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:19 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 0x7fbe6f38cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1108410>, '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 0x1109310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11097a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', '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 07:28:19 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 07:28:19 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 07:28:19 INFO - Using env: {'DISPLAY': ':0', 07:28:19 INFO - 'HOME': '/home/cltbld', 07:28:19 INFO - 'LANG': 'en_US.UTF-8', 07:28:19 INFO - 'LANGUAGE': 'en_US:en', 07:28:19 INFO - 'LOGNAME': 'cltbld', 07:28:19 INFO - 'MAIL': '/var/mail/cltbld', 07:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:19 INFO - 'MOZ_NO_REMOTE': '1', 07:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:19 INFO - 'NO_EM_RESTART': '1', 07:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:19 INFO - 'PWD': '/builds/slave/test', 07:28:19 INFO - 'SHELL': '/bin/bash', 07:28:19 INFO - 'SHLVL': '1', 07:28:19 INFO - 'TERM': 'linux', 07:28:19 INFO - 'TMOUT': '86400', 07:28:19 INFO - 'USER': 'cltbld', 07:28:19 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', 07:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:19 INFO - '_': '/tools/buildbot/bin/python'} 07:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:28:21 INFO - Installing collected packages: mozsystemmonitor 07:28:21 INFO - Running setup.py install for mozsystemmonitor 07:28:21 INFO - Successfully installed mozsystemmonitor 07:28:21 INFO - Cleaning up... 07:28:22 INFO - Return code: 0 07:28:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:22 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 0x7fbe6f38cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1108410>, '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 0x1109310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11097a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', '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 07:28:22 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 07:28:22 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 07:28:22 INFO - Using env: {'DISPLAY': ':0', 07:28:22 INFO - 'HOME': '/home/cltbld', 07:28:22 INFO - 'LANG': 'en_US.UTF-8', 07:28:22 INFO - 'LANGUAGE': 'en_US:en', 07:28:22 INFO - 'LOGNAME': 'cltbld', 07:28:22 INFO - 'MAIL': '/var/mail/cltbld', 07:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:22 INFO - 'MOZ_NO_REMOTE': '1', 07:28:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:22 INFO - 'NO_EM_RESTART': '1', 07:28:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:22 INFO - 'PWD': '/builds/slave/test', 07:28:22 INFO - 'SHELL': '/bin/bash', 07:28:22 INFO - 'SHLVL': '1', 07:28:22 INFO - 'TERM': 'linux', 07:28:22 INFO - 'TMOUT': '86400', 07:28:22 INFO - 'USER': 'cltbld', 07:28:22 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', 07:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:22 INFO - '_': '/tools/buildbot/bin/python'} 07:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:22 INFO - Downloading/unpacking blobuploader==1.2.4 07:28:22 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 07:28:22 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 07:28:22 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 07:28:22 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 07:28:22 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 07:28:22 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 07:28:24 INFO - Downloading blobuploader-1.2.4.tar.gz 07:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:28:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:28:24 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 07:28:24 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 07:28:24 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 07:28:24 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 07:28:24 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 07:28:24 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 07:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:28:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:28:24 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 07:28:24 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 07:28:24 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 07:28:24 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 07:28:24 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 07:28:24 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 07:28:24 INFO - Downloading docopt-0.6.1.tar.gz 07:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:28:24 INFO - Installing collected packages: blobuploader, requests, docopt 07:28:24 INFO - Running setup.py install for blobuploader 07:28:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:28:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:28:24 INFO - Running setup.py install for requests 07:28:25 INFO - Running setup.py install for docopt 07:28:25 INFO - Successfully installed blobuploader requests docopt 07:28:25 INFO - Cleaning up... 07:28:25 INFO - Return code: 0 07:28:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:25 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 0x7fbe6f38cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1108410>, '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 0x1109310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11097a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', '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 07:28:25 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 07:28:25 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 07:28:25 INFO - Using env: {'DISPLAY': ':0', 07:28:25 INFO - 'HOME': '/home/cltbld', 07:28:25 INFO - 'LANG': 'en_US.UTF-8', 07:28:25 INFO - 'LANGUAGE': 'en_US:en', 07:28:25 INFO - 'LOGNAME': 'cltbld', 07:28:25 INFO - 'MAIL': '/var/mail/cltbld', 07:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:25 INFO - 'MOZ_NO_REMOTE': '1', 07:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:25 INFO - 'NO_EM_RESTART': '1', 07:28:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:25 INFO - 'PWD': '/builds/slave/test', 07:28:25 INFO - 'SHELL': '/bin/bash', 07:28:25 INFO - 'SHLVL': '1', 07:28:25 INFO - 'TERM': 'linux', 07:28:25 INFO - 'TMOUT': '86400', 07:28:25 INFO - 'USER': 'cltbld', 07:28:25 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', 07:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:25 INFO - '_': '/tools/buildbot/bin/python'} 07:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:25 INFO - Running setup.py (path:/tmp/pip-i87Nnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:25 INFO - Running setup.py (path:/tmp/pip-aBGEwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:25 INFO - Running setup.py (path:/tmp/pip-lhRmU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:25 INFO - Running setup.py (path:/tmp/pip-1vMAyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:25 INFO - Running setup.py (path:/tmp/pip-n64yT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:26 INFO - Running setup.py (path:/tmp/pip-RhiCIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:26 INFO - Running setup.py (path:/tmp/pip-D5xn2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:26 INFO - Running setup.py (path:/tmp/pip-wozFRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:26 INFO - Running setup.py (path:/tmp/pip-l9axHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:26 INFO - Running setup.py (path:/tmp/pip-l6DIf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:26 INFO - Running setup.py (path:/tmp/pip-YbOhs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:26 INFO - Running setup.py (path:/tmp/pip-PdkeRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:26 INFO - Running setup.py (path:/tmp/pip-FSdo92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:26 INFO - Running setup.py (path:/tmp/pip-50uu2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:26 INFO - Running setup.py (path:/tmp/pip-ws8NME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:26 INFO - Running setup.py (path:/tmp/pip-_FIiUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:26 INFO - Running setup.py (path:/tmp/pip-aL8CA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:28:26 INFO - Running setup.py install for manifestparser 07:28:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:28:27 INFO - Running setup.py install for mozcrash 07:28:27 INFO - Running setup.py install for mozdebug 07:28:27 INFO - Running setup.py install for mozdevice 07:28:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:28:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:28:27 INFO - Running setup.py install for mozfile 07:28:27 INFO - Running setup.py install for mozhttpd 07:28:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:28:27 INFO - Running setup.py install for mozinfo 07:28:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:28:27 INFO - Running setup.py install for mozInstall 07:28:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:28:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:28:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:28:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:28:27 INFO - Running setup.py install for mozleak 07:28:27 INFO - Running setup.py install for mozlog 07:28:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:28:27 INFO - Running setup.py install for moznetwork 07:28:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:28:28 INFO - Running setup.py install for mozprocess 07:28:28 INFO - Running setup.py install for mozprofile 07:28:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:28:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:28:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:28:28 INFO - Running setup.py install for mozrunner 07:28:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:28:28 INFO - Running setup.py install for mozscreenshot 07:28:28 INFO - Running setup.py install for moztest 07:28:28 INFO - Running setup.py install for mozversion 07:28:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:28:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:28:28 INFO - Cleaning up... 07:28:28 INFO - Return code: 0 07:28:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:28 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 0x7fbe6f38cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1108410>, '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 0x1109310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11097a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', '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 07:28:28 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 07:28:28 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 07:28:28 INFO - Using env: {'DISPLAY': ':0', 07:28:28 INFO - 'HOME': '/home/cltbld', 07:28:28 INFO - 'LANG': 'en_US.UTF-8', 07:28:28 INFO - 'LANGUAGE': 'en_US:en', 07:28:28 INFO - 'LOGNAME': 'cltbld', 07:28:28 INFO - 'MAIL': '/var/mail/cltbld', 07:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:28 INFO - 'MOZ_NO_REMOTE': '1', 07:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:28 INFO - 'NO_EM_RESTART': '1', 07:28:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:28 INFO - 'PWD': '/builds/slave/test', 07:28:28 INFO - 'SHELL': '/bin/bash', 07:28:28 INFO - 'SHLVL': '1', 07:28:28 INFO - 'TERM': 'linux', 07:28:28 INFO - 'TMOUT': '86400', 07:28:28 INFO - 'USER': 'cltbld', 07:28:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', 07:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:28 INFO - '_': '/tools/buildbot/bin/python'} 07:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:28 INFO - Running setup.py (path:/tmp/pip-uIAY5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:28 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)) 07:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:28 INFO - Running setup.py (path:/tmp/pip-qjqxTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:29 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)) 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:29 INFO - Running setup.py (path:/tmp/pip-ooQNAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:29 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)) 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:29 INFO - Running setup.py (path:/tmp/pip-WSJTCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:29 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)) 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:29 INFO - Running setup.py (path:/tmp/pip-AOUrTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:29 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)) 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:29 INFO - Running setup.py (path:/tmp/pip-YxOISw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:29 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)) 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:29 INFO - Running setup.py (path:/tmp/pip-BzzCwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:29 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)) 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:29 INFO - Running setup.py (path:/tmp/pip-J4AJMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:29 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)) 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:29 INFO - Running setup.py (path:/tmp/pip-6X2v9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:29 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)) 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:29 INFO - Running setup.py (path:/tmp/pip-KUdxiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:29 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)) 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:29 INFO - Running setup.py (path:/tmp/pip-bryTw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:29 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)) 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:29 INFO - Running setup.py (path:/tmp/pip-9dz_rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:29 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)) 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:29 INFO - Running setup.py (path:/tmp/pip-HKMarB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:29 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)) 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:29 INFO - Running setup.py (path:/tmp/pip-bPLT3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:29 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)) 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:29 INFO - Running setup.py (path:/tmp/pip-YyR1MB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:30 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)) 07:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:30 INFO - Running setup.py (path:/tmp/pip-flWY0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:30 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)) 07:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:30 INFO - Running setup.py (path:/tmp/pip-gUNE6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:30 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)) 07:28:30 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)) 07:28:30 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)) 07:28:30 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)) 07:28:30 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)) 07:28:30 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)) 07:28:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:32 INFO - Downloading blessings-1.6.tar.gz 07:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:28:32 INFO - Installing collected packages: blessings 07:28:32 INFO - Running setup.py install for blessings 07:28:32 INFO - Successfully installed blessings 07:28:32 INFO - Cleaning up... 07:28:32 INFO - Return code: 0 07:28:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:28:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:32 INFO - Reading from file tmpfile_stdout 07:28:32 INFO - Current package versions: 07:28:32 INFO - argparse == 1.2.1 07:28:32 INFO - blessings == 1.6 07:28:32 INFO - blobuploader == 1.2.4 07:28:32 INFO - docopt == 0.6.1 07:28:32 INFO - manifestparser == 1.1 07:28:32 INFO - mozInstall == 1.12 07:28:32 INFO - mozcrash == 0.17 07:28:32 INFO - mozdebug == 0.1 07:28:32 INFO - mozdevice == 0.48 07:28:32 INFO - mozfile == 1.2 07:28:32 INFO - mozhttpd == 0.7 07:28:32 INFO - mozinfo == 0.9 07:28:32 INFO - mozleak == 0.1 07:28:32 INFO - mozlog == 3.1 07:28:32 INFO - moznetwork == 0.27 07:28:32 INFO - mozprocess == 0.22 07:28:32 INFO - mozprofile == 0.28 07:28:32 INFO - mozrunner == 6.11 07:28:32 INFO - mozscreenshot == 0.1 07:28:32 INFO - mozsystemmonitor == 0.0 07:28:32 INFO - moztest == 0.7 07:28:32 INFO - mozversion == 1.4 07:28:32 INFO - psutil == 3.1.1 07:28:32 INFO - requests == 1.2.3 07:28:32 INFO - wsgiref == 0.1.2 07:28:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:32 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 0x7fbe6f38cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1108410>, '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 0x1109310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11097a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', '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 07:28:32 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 07:28:32 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 07:28:32 INFO - Using env: {'DISPLAY': ':0', 07:28:32 INFO - 'HOME': '/home/cltbld', 07:28:32 INFO - 'LANG': 'en_US.UTF-8', 07:28:32 INFO - 'LANGUAGE': 'en_US:en', 07:28:32 INFO - 'LOGNAME': 'cltbld', 07:28:32 INFO - 'MAIL': '/var/mail/cltbld', 07:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:32 INFO - 'MOZ_NO_REMOTE': '1', 07:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:32 INFO - 'NO_EM_RESTART': '1', 07:28:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:32 INFO - 'PWD': '/builds/slave/test', 07:28:32 INFO - 'SHELL': '/bin/bash', 07:28:32 INFO - 'SHLVL': '1', 07:28:32 INFO - 'TERM': 'linux', 07:28:32 INFO - 'TMOUT': '86400', 07:28:32 INFO - 'USER': 'cltbld', 07:28:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', 07:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:32 INFO - '_': '/tools/buildbot/bin/python'} 07:28:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:32 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)) 07:28:32 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)) 07:28:32 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)) 07:28:32 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)) 07:28:32 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)) 07:28:32 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)) 07:28:32 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)) 07:28:32 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)) 07:28:32 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)) 07:28:32 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)) 07:28:32 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)) 07:28:32 INFO - Cleaning up... 07:28:32 INFO - Return code: 0 07:28:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe6f38cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1108410>, '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 0x1109310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11097a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', '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 07:28:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:28:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:28:32 INFO - Using env: {'DISPLAY': ':0', 07:28:32 INFO - 'HOME': '/home/cltbld', 07:28:32 INFO - 'LANG': 'en_US.UTF-8', 07:28:32 INFO - 'LANGUAGE': 'en_US:en', 07:28:32 INFO - 'LOGNAME': 'cltbld', 07:28:32 INFO - 'MAIL': '/var/mail/cltbld', 07:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:32 INFO - 'MOZ_NO_REMOTE': '1', 07:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:32 INFO - 'NO_EM_RESTART': '1', 07:28:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:32 INFO - 'PWD': '/builds/slave/test', 07:28:32 INFO - 'SHELL': '/bin/bash', 07:28:32 INFO - 'SHLVL': '1', 07:28:32 INFO - 'TERM': 'linux', 07:28:32 INFO - 'TMOUT': '86400', 07:28:32 INFO - 'USER': 'cltbld', 07:28:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', 07:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:32 INFO - '_': '/tools/buildbot/bin/python'} 07:28:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:32 INFO - Downloading/unpacking jsonschema 07:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:28:34 INFO - Downloading/unpacking functools32 (from jsonschema) 07:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:34 INFO - Downloading functools32-3.2.3-2.tar.gz 07:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:28:35 INFO - warning: no files found matching '*.txt' 07:28:35 INFO - no previously-included directories found matching 'build' 07:28:35 INFO - no previously-included directories found matching 'dist' 07:28:35 INFO - no previously-included directories found matching '.git*' 07:28:35 INFO - Installing collected packages: jsonschema, functools32 07:28:35 INFO - Running setup.py install for functools32 07:28:35 INFO - warning: no files found matching '*.txt' 07:28:35 INFO - no previously-included directories found matching 'build' 07:28:35 INFO - no previously-included directories found matching 'dist' 07:28:35 INFO - no previously-included directories found matching '.git*' 07:28:35 INFO - Successfully installed jsonschema functools32 07:28:35 INFO - Cleaning up... 07:28:35 INFO - Return code: 0 07:28:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe6f38cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1108410>, '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 0x1109310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11097a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', '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 07:28:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:28:35 INFO - Using env: {'DISPLAY': ':0', 07:28:35 INFO - 'HOME': '/home/cltbld', 07:28:35 INFO - 'LANG': 'en_US.UTF-8', 07:28:35 INFO - 'LANGUAGE': 'en_US:en', 07:28:35 INFO - 'LOGNAME': 'cltbld', 07:28:35 INFO - 'MAIL': '/var/mail/cltbld', 07:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:35 INFO - 'MOZ_NO_REMOTE': '1', 07:28:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:35 INFO - 'NO_EM_RESTART': '1', 07:28:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:35 INFO - 'PWD': '/builds/slave/test', 07:28:35 INFO - 'SHELL': '/bin/bash', 07:28:35 INFO - 'SHLVL': '1', 07:28:35 INFO - 'TERM': 'linux', 07:28:35 INFO - 'TMOUT': '86400', 07:28:35 INFO - 'USER': 'cltbld', 07:28:35 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', 07:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:35 INFO - '_': '/tools/buildbot/bin/python'} 07:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:35 INFO - Downloading/unpacking flake8 07:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:28:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:28:37 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 07:28:37 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 07:28:37 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 07:28:37 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 07:28:37 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 07:28:37 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 07:28:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:28:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:28:37 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 07:28:37 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 07:28:37 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 07:28:37 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 07:28:37 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 07:28:37 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 07:28:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:28:37 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 07:28:37 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 07:28:37 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 07:28:37 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 07:28:37 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 07:28:37 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 07:28:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:28:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:28:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:28:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:28:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:28:38 INFO - no previously-included directories found matching 'docs/_build' 07:28:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:28:38 INFO - Running setup.py install for pep8 07:28:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:28:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:28:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:28:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:28:38 INFO - no previously-included directories found matching 'docs/_build' 07:28:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:28:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:28:38 INFO - Cleaning up... 07:28:38 INFO - Return code: 0 07:28:38 INFO - Running post-action listener: _resource_record_post_action 07:28:38 INFO - Running post-action listener: _start_resource_monitoring 07:28:38 INFO - Starting resource monitoring. 07:28:38 INFO - ##### 07:28:38 INFO - ##### Finished create-virtualenv step (success) 07:28:38 INFO - ##### 07:28:38 INFO - ##### 07:28:38 INFO - ##### Running install step. 07:28:38 INFO - ##### 07:28:38 INFO - Running pre-action listener: _resource_record_pre_action 07:28:38 INFO - Running main action method: install 07:28:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:38 INFO - Reading from file tmpfile_stdout 07:28:38 INFO - Detecting whether we're running mozinstall >=1.0... 07:28:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:28:38 INFO - Reading from file tmpfile_stdout 07:28:38 INFO - Output received: 07:28:38 INFO - Usage: mozinstall [options] installer 07:28:38 INFO - Options: 07:28:38 INFO - -h, --help show this help message and exit 07:28:38 INFO - -d DEST, --destination=DEST 07:28:38 INFO - Directory to install application into. [default: 07:28:38 INFO - "/builds/slave/test"] 07:28:38 INFO - --app=APP Application being installed. [default: firefox] 07:28:38 INFO - mkdir: /builds/slave/test/build/application 07:28:38 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'] 07:28:38 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 07:28:54 INFO - Reading from file tmpfile_stdout 07:28:54 INFO - Output received: 07:28:54 INFO - /builds/slave/test/build/application/firefox/firefox 07:28:54 INFO - Running post-action listener: _resource_record_post_action 07:28:54 INFO - ##### 07:28:54 INFO - ##### Finished install step (success) 07:28:54 INFO - ##### 07:28:54 INFO - ##### 07:28:54 INFO - ##### Running run-tests step. 07:28:54 INFO - ##### 07:28:54 INFO - Running pre-action listener: _resource_record_pre_action 07:28:54 INFO - Running main action method: run_tests 07:28:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:28:54 INFO - Python 2.7.3 07:28:54 INFO - Return code: 0 07:28:54 INFO - grabbing minidump binary from tooltool 07:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:54 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 0x1108410>, '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 0x1109310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11097a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:28:54 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 07:28:54 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 07:28:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:28:54 INFO - Return code: 0 07:28:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:28:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:28:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:28:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:28:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:28:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:28:55 INFO - Return code: 0 07:28:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:28:55 INFO - Using env: {'DISPLAY': ':0', 07:28:55 INFO - 'HOME': '/home/cltbld', 07:28:55 INFO - 'LANG': 'en_US.UTF-8', 07:28:55 INFO - 'LANGUAGE': 'en_US:en', 07:28:55 INFO - 'LOGNAME': 'cltbld', 07:28:55 INFO - 'MAIL': '/var/mail/cltbld', 07:28:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:28:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:55 INFO - 'MOZ_NO_REMOTE': '1', 07:28:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:55 INFO - 'NO_EM_RESTART': '1', 07:28:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:55 INFO - 'PWD': '/builds/slave/test', 07:28:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:28:55 INFO - 'SHELL': '/bin/bash', 07:28:55 INFO - 'SHLVL': '1', 07:28:55 INFO - 'TERM': 'linux', 07:28:55 INFO - 'TMOUT': '86400', 07:28:55 INFO - 'USER': 'cltbld', 07:28:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730', 07:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:55 INFO - '_': '/tools/buildbot/bin/python'} 07:28:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:28:55 INFO - mozversion application_buildid: 20160506064620 07:28:55 INFO - mozversion application_changeset: f97139bf14beb480b3255c69b3e43f376c548e31 07:28:55 INFO - mozversion application_display_name: Nightly 07:28:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:28:55 INFO - mozversion application_name: Firefox 07:28:55 INFO - mozversion application_remotingname: firefox 07:28:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:28:55 INFO - mozversion application_vendor: Mozilla 07:28:55 INFO - mozversion application_version: 49.0a1 07:28:55 INFO - mozversion platform_buildid: 20160506064620 07:28:55 INFO - mozversion platform_changeset: f97139bf14beb480b3255c69b3e43f376c548e31 07:28:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:28:55 INFO - mozversion platform_version: 49.0a1 07:28:55 INFO - using testdate: 1462544935 07:28:55 INFO - actual date: 1462544935 07:28:55 INFO - starting webserver on 'localhost:34996' 07:28:55 INFO - SUITE-START | Running 2 tests 07:28:55 INFO - TEST-START | dromaeo_css 07:28:55 INFO - operating with platform_type : linux_ 07:28:55 INFO - Initialising browser for dromaeo_css test... 07:28:55 INFO - TEST-INFO | started process 14309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1sW_Ym/profile http://localhost:34996/getInfo.html) 07:29:00 INFO - PROCESS | 14309 | __metrics Screen width/height:1600/1200 07:29:00 INFO - PROCESS | 14309 | colorDepth:24 07:29:00 INFO - PROCESS | 14309 | Browser inner width/height: 1024/697 07:29:00 INFO - PROCESS | 14309 | __metrics 07:29:01 ERROR - PROCESS | 14309 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:29:02 INFO - TEST-INFO | 14309: exit 0 07:29:02 INFO - Browser initialized. 07:29:02 INFO - Running cycle 1/1 for dromaeo_css test... 07:29:02 INFO - TEST-INFO | started process 14392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1sW_Ym/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:14 INFO - PROCESS | 14392 | RSS: Main: 154415104 07:29:14 INFO - PROCESS | 14392 | 07:30:05 INFO - PROCESS | 14392 | 1462545005726 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] 07:32:17 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:34996/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34996/tests/dromaeo/cssquery-ext.html) 07:32:18 INFO - PROCESS | 14392 | RSS: Main: 272990208 07:32:18 INFO - PROCESS | 14392 | 07:35:21 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:34996/tests/dromaeo/cssquery-ext.html (next: http://localhost:34996/tests/dromaeo/cssquery-jquery.html) 07:35:21 INFO - PROCESS | 14392 | RSS: Main: 239599616 07:35:21 INFO - PROCESS | 14392 | 07:38:24 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:34996/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34996/tests/dromaeo/cssquery-mootools.html) 07:38:24 INFO - PROCESS | 14392 | RSS: Main: 245321728 07:38:24 INFO - PROCESS | 14392 | 07:41:26 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:34996/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34996/tests/dromaeo/cssquery-prototype.html) 07:41:27 INFO - PROCESS | 14392 | RSS: Main: 244469760 07:41:27 INFO - PROCESS | 14392 | 07:44:30 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:34996/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34996/tests/dromaeo/cssquery-yui.html) 07:44:30 INFO - PROCESS | 14392 | RSS: Main: 220123136 07:44:30 INFO - PROCESS | 14392 | 07:47:33 INFO - PROCESS | 14392 | Cycle 1(1): loaded http://localhost:34996/tests/dromaeo/cssquery-yui.html (next: http://localhost:34996/tests/dromaeo/cssquery-dojo.html) 07:47:34 INFO - PROCESS | 14392 | RSS: Main: 271962112 07:47:34 INFO - PROCESS | 14392 | 07:47:34 INFO - PROCESS | 14392 | __start_tp_report 07:47:34 INFO - PROCESS | 14392 | _x_x_mozilla_page_load 07:47:34 INFO - PROCESS | 14392 | _x_x_mozilla_page_load_details 07:47:34 INFO - PROCESS | 14392 | |i|pagename|runs| 07:47:34 INFO - PROCESS | 14392 | |0;dojo.html;2623.6195751616015;2643.9867800660995;2671.4790615829907;2675.8528280944543;2685.2347081081894;4519.27691569349;4591.517890621479;4630.097131059445;4718.315844202589;4754.572088512034;4648.23304154814;4691.2024955757515;4745.3593764841735;4756.191447453933;4845.491223421543;4305.526392096866;4320.546342634026;4323.502797178333;4336.3712261722185;4449.911001779962;4341.28368819146;4441.178381999324;4465.933011004838;4505.279155335147;4512.751798651073;4218.514870789868;4405.251107311765;4452.7996240169105;4458.019235768126;4467.508574056851;4253.128108737701;4284.871453856389;4319.719218250835;4323.718958267703;4330.069035157425;4293.892652683677;4341.088371442001;4357.477102747691;4360.65114790816;4387.254166791653;4428.844990425319;4608.585227329523;4660.04469083837;4680.4149481314835;4687.859364219079;4984.077945580043;5067.315912351823;5073.2643766654;5098.59211263098;5151.304573882516;5102.872428189288;5141.2545180948555;5151.201563757623;5164.715940623264;5171.948280517185;4596.264597664424;4634.2585186370015;4818.180909245367;4827.372441582607;4828.855134345975;5090.2364645303505;5100.209467532539;5173.767180476888;5174.120399532088;5176.275321454999;4895.926561101586;4914;4920.532549407801;4986.102501549683;4997.225430058346;4870.537298956593;4965.9751701241985;5005.074061298671;5011.273365362002;5015.84952451427;4961.05739909416;4980.178270585386;4983.651144419856;4986.152354099811;5019.974900125476;4965.255211718199;4967.552920237196;4969.055879382906;4970.925436118461;5009.073321435546;4202.705810593229;4246.299360605527;4284.957150428519;4321.67587430944;4333.804978775963;3761.8119094045187;3763.7365384423374;3806.0294624871035;3816.656500914931;3863.150106976461;4331.306990881444;4333.43665323506;4341.39220509129;4375.606195442362;4383.539728328479;4845.079434907357;5051.217061355495;5058.949410505921;5108.923366149511;5114.0539000284325;4379.5182529921685;4406.405135306757;4408.933865992013;4410.272305069628;4452;4638.8608341749805;4649.837255696035;4650.883727906762;4655.767211639472;4705.294205869079;4528.184926713157;4693.319468677091;4740.6444516660695;4743.169945259497;4769.73766442849;5071.4421413645205;5076.314697515788;5084.161113416393;5094.719790411563;5146.408163061295;4562.041971186088;4748.358971538798;4761.047790441856;4761.071591039714;4814.133455977958;4967.254911763264;4971.477994810492;5012.498750124958;5023.598112151092;5037.7733002014265;5051.74741262928;5067.062593420229;5067.062593420229;5086.872828179326;5148.176291793295;4690.366800481891;4795.064962332312;4898.167311557115;4913.385826771653;4968.329275547755;4829.27560865873;4838.637102217418;4862.805487780591;4867.14824905633;4908.92636610444;4791.592714619296;4799.28010798383;4840.54014868601;4891.559759621651;4891.755412229445;4754.857354279239;4930.5069493050405;4954.256861470808;4993.450720420823;5005.074061298671;4798.376211092535;4839.395075615548;4869.074875773592;4911.63162762787;4921.163402221559 07:47:34 INFO - PROCESS | 14392 | |1;ext.html;553.6927005511942;595.5444085274765;598.5959477352787;608.2275510102173;611.8164550634808;41871.79064104679;42970.35544466832;43003.78498107509;47433;47548.52451475484;43616.781916090455;43729.56270437295;44109.558904410944;44117.11765764683;44176.3373549397;8002.679892804281;8108.310793582553;8118.309943654796;8118.553479558622;8123.065847427532;7918.168592297812;7934.880976785353;7960.40296977729;8004.159563245863;8038;8095.55474448908;8134.308583770387;8134.796630084265;8135.145809689957;8141.145179756129;8037.718679846206;8041.276285134366;8063.435559510836;8073.1119576846795;8086.353091752646;8048.59757012147;8108.797280067986;8111.594420278962;8115.066767321775;8121.431499795017;40298.59701402978;40630.593694063275;40651.390229146586;40696.79651601723;40723.796381018205;3252.8210948397827;3299.340131973591;3356.748243881694;3448.499967504698;3602.981985090084;29952;30223.244418889484;30226.244343891358;30299.69700302991;30465;3374.190194353362;3383.069655844638;3445.672661097192;3458.56767904012;3552.342816578941;260033;260492.697536513;261411;261611;261690;34181.48727769085;34715.65284347175;57955.71022144862;58197.127043094384;58670.41329586735;34258.657413426045;34312.48531272033;34364.48453273203;34371.828140859136;34392;14248.786268205986;14478.348474318682;14482.34829432678;14484.565463036126;14485.637859053608;11585.826212606818;11774.94112529432;11793.587224447103;11804.527818887149;11807.527698891949;8333.499990000499;8359.038710548242;8421;8476.915230847735;8488.83022339562;3233.692799184074;3274.3287626036604;3288.8355582220793;3300.603927528712;3313.5029745538363;907.0905743410159;946.6875930942772;974.3715303629261;1003.5985605757755;1042.0881728487423;29353.266168345963;29466.263343416158;29528.409431811673;30143.547846782316;30203;1026.2559644257854;1064.3720205078885;1070.2347821307803;1086.7174534621056;1100.0374672161859;15161.241937903062;15558.377664893504;15640;15847.286872090783;15852.52442426729;380818;752733;775455;775593;776363;52060.31457168873;52297.47702523002;52883;52917.20624190563;52953.7352313236;1173.7417768091007;1293.2822283632486;1298.4222021200476;1317.4466723975954;1333.1467860569244;27770.305742356602;30075.24811879633;30258.84870575721;30648.387032259678;30721.231969200948;44430.77784611056;44653.330200046374;45075.549244508446;45097;45118.548814511436;283285;284616;285991;286284;286892;23549.29352119439;26364.472710546066;26723.866380667972;26780.59829102604;26804;42912.141757164056;43369;43497.34753978756;44124.55875441204;44719.55280447154;36701.26597467982;37559.43660845035;37632.247355053296;37993.240135197695;38282.23435531218;36597.268054638225;37300;37307.44038839474;37583.43624845684;37893.24213515769;37004.629953701195;37276.813615931744;38752.806235969765;39445.2110957785;39568.40647390349;30878.38243235168;33054.834725826215;33217.83391083029;33422;33659;24683.136090236756;25059.624105638064;25169.87415062986;25347.61978570286;25577.488450230518 07:47:34 INFO - PROCESS | 14392 | |2;jquery.html;369.1417454418476;373.2832960715426;375.9680427163691;382.32901258291696;391.3952942703523;16179.514614561553;17541.298348066095;17586.648267034667;17856.553586160353;18048.278068877262;11223.719407014829;16288;17011.489655310328;17077.487675369728;17467.777255592082;4685.531446855304;4797.496262892399;4816.036792641468;4851.296561998508;4851.442084160331;3377.8986630401128;4776.4268287805335;5243.973780131113;5500.917486237709;5534.252875861747;5597.076482380402;5602.887942241153;5627.943720562783;5629.408912064236;5636.605437619368;5364.704941228231;5514.80698175566;5525.861853453655;5564.4713752193675;5572.60991730581;3328.5839270091237;4943.9258411123865;5222.608304377149;5225.843224703265;5291;12401.13192076555;12406.441710122976;12476.875231247663;12594.496220151183;12635.620931372074;1977.6341376845187;1981.0094952523739;2043.0601923115385;2077.6052550015447;2129.169623846701;8885;9325.253979681609;9526.476043817587;9555.092266234697;9694.321397502177;1782.7949785774672;1788.2668106076446;1814.7822261328593;1845.9077046147772;1889.7070954002152;66241.33758662448;66735;67007.32992670109;67784.6610766943;68301.65849170722;8269.21442462965;8867.73396798097;8909.242714369351;9392.248620110375;9458;12363.134580579273;12366.319852408204;12426.75146497083;12426.937865310616;12427.37863106841;7247.658999184799;7256.7097316106765;7268.96365518169;7483.4761566690895;7515.812104697427;7383.187849336568;7435.367993720594;7523.8495230095095;7529.832875904243;7552.093748750185;3850.4609354690365;3874.4575759393706;3910.980445097813;3943.684505239574;3963.6630886374405;1743.6599863026588;1775.520609435471;1833.871628985985;1851.3797877711118;1872.6816441205028;874.9562521874008;892.0187793427178;941.8069295794346;955.7897262602216;968.660968660963;16838.073905935293;17121.828781712273;17278.22247998818;17481.213345399232;17776.822231777776;893.6872094766779;909.2816674826945;921.3504479342182;929.0338048429693;931.6366617019368;9496.382735122195;9573.18627916621;9650.565724542412;9718.562664680107;9916.652917147865;142817;143473;253245.73377132998;400620;406390;46225.7688711561;46393.53606463892;75332;78679.60660196662;81963;949.7008442340779;986.2159583131571;1003.2626019875386;1006.5772375602264;1014.9391036537831;15917.317299350936;15924.442644507386;15959.760603590723;16063.11652859104;16466.83533164701;29002;31893.36213275768;35471.29057418786;35566;35766.463503048;44239.336409953234;46210.768946155054;49710;51502.74248628733;52134;7497.737579184703;7552.735654252295;7592.050993625797;7616.543007419573;7659;9379.765505862408;11404.771904561696;11644.486216791764;11883.346415947206;11938.820917686415;6680.966595166993;10096.34373765703;10364.03083414149;10380.221483388927;10417.9479102604;8654.78363040929;9212.447253164832;9461.858072129062;9730;9838.75403114928;10450.111740502143;10515;10588.788224235319;10690.62582809598;10721.463926803473;7718.112417072109;7736.627148166981;7820;7970.721024764105;7987.161348058603;10196.643117490852;10292.228082893664;10292.330998485075;10349.896501034893;10371.170306375321 07:47:34 INFO - PROCESS | 14392 | |3;mootools.html;1301.0632344711805;1508.6530098077442;1544.89185756997;1626.967460650787;1796.37127005548;7135.143782746071;7344.081989751281;7357.521761085526;7529.3976481881455;7538.698452061924;7394.704211831534;7562.508436951594;7575.166731659527;7578.3558397536135;7585.241475852412;1897.7153426985994;1961.5292329840806;1963.4600484866705;2178.400939741572;2214.734231892175;2193.846430749848;2252.3468194223656;2253.785890340423;2262.1177740681146;2264.33202205349;2156.762756096828;2166.490874644457;2185.2024011235944;2189.8029177374033;2198.7801219878043;1841.4107485604611;2119.73503312086;2148.0977989244557;2149.3337065509663;2158.4927542027613;2122.862013969087;2142.389419015589;2144.957100857974;2148.291063948893;2151;7559.659815308324;7599.392048636096;7609.505382150142;7612.695492180306;7615.238476152396;4389.890252743675;4482.574155455227;4510.300903359985;4547.18150732868;4553.362529245908;2633.0784225521106;2730.235534050449;2750;2754.394033312668;2757.889684412621;839.9244068033906;883.3904605821963;895.892492900856;1658.1211957662458;1719.2950890134985;9967.252456065751;9994.200463962865;10134.290599658027;10136.037076477724;10142.442165680885;3982.0443093657314;4035.1929614076716;4088.897777555585;4113.053997580573;4113.958860411418;8062.879056814152;8104.675812967534;8139.4709343892455;8143.918560814434;8145.144759800254;4459.108178364275;4459.531749166291;4465.508794032654;4469.687121901501;4472.44094488189;3611.8735844245325;3975.4434379186937;4092.4475195848777;4152.065785198306;4179.519355274121;3419.65803419661;3466.584009918826;3485.5643044619424;3501.2647344057523;3563.6614521620922;1036.6009086501601;1038.1487180511908;1041.422010784007;1047.4710271312938;1072.126217133034;871.9128087191231;889.8665200220019;891.5631340643038;897.8114595934927;902.0618556700957;5179.818706345335;5225.869353266199;5325.707086110301;5368.087425137736;5394.73026348681;392.73490393983946;410.13256961526156;411.8929078439567;411.94232807406985;417.6637806565683;3638.2692019763226;3651.2879988402005;3702.72229582777;3748.9250214995545;3758.3047136279874;9006.684766033157;9372.062793720574;9427.387219830825;9537.856932146024;9588.952055239819;9419.717408477756;9495.097965693249;9515.143637072559;9528.094830991045;9532.618695252251;7086.18508871476;7184.640767961581;7277.818054548678;7373;7380.077490313711;4941.43173535048;5087.414947280962;5161.406438259648;5204.297419848272;5205.921911171411;8523.95738021306;8529.87205191935;8650.524221167896;8822.07368226327;8868.733937981871;8801.735947921317;8809.471431714117;8903.243224326005;8944.86582701273;9033.954830225806;5574.191742197439;5733.082706766897;5737.713114344349;6289.433950944437;6360.554761166674;6903.861922761416;6965.860682786417;7061.046758687511;7314.305141011595;7343.41252699772;6524.282328943717;6774.356436138559;6847.452203823583;6864.931350686629;6939.30606939302;6588.04473351371;6602.1747281589805;6635.800925972036;6673.332666733288;6713.295104014203;6326.620402775849;6366.713497892699;6392.296847346695;6402.551821372459;6404.135441715309;4502.729836209838;4614.861554153381;4653.255479123324;4689.765511724332;4706;4776.694762912922;4822.9758851205515;4847.054824309226;4877.658803719463;4967.3542439482635 07:47:34 INFO - PROCESS | 14392 | |4;prototype.html;296.8189404463277;297.05240283495647;303.3235883978727;308.90423968569746;309.5588785979978;4781.306710526971;4807.966287248241;4830.710157390555;4856.538628830264;4860.829870954517;4502.504724480313;4547.567981041796;4664.8134074637055;4682.531746825316;4771.904561908768;3730.1980074284024;3748.5314335708035;3754.361758501048;3763.7177211709095;3764.5670747864074;3734.7945862977526;3749.568799588055;3751.643593858579;3765.3787125124322;3772.3398405279104;3529.7705649132854;3625.4743062255957;3714.848396996926;3742.7380083394173;3744.8876533703897;3684.5025921500524;3686.041629176407;3721.1813401051727;3727.732570925885;3741.102135487477;3302.735781137503;3307.570015897942;3317.319949410389;3328.7503437242303;3345.0466617014035;4370.147821174872;4485;4520.299353600197;4547.567981041796;4572.314152877062;4214.840918747338;4233.386159006957;4266.616004559573;4267.957320426787;4290.120525292307;4885.487023862479;4905.484924082992;4918.23767316063;4928.457869634337;4972.8508144755715;3625.6193099724414;3626.34725749365;3638.2905333459985;3648.6168952259895;3656.360136976045;4961.5038496150455;5145.794168233266;5164.354455693038;5166.638335316529;5180.352455943007;3676.7793932364143;3678.9448158277114;3685.1339935115225;3699.4265888786745;3740.36413809653;3753.348526648321;3770.6229377062073;3774.1319496515957;3794.4687743715904;3794.79128647927;4019.336809426412;4183.267928112568;4224.345226489838;4224.91550169001;4289.699721019561;4979.45226025137;5003.549680528697;5018.723970181602;5027.949720502748;5038.924416133761;1170.7190274334098;1205.6383085074442;1249.5564074753513;1254.2787896959285;1257.2205232755566;842.1704620948361;855.2473823035689;859.9699010534727;860.2300940658076;861.5390765940192;4227.260229459832;4234.661227101825;4262.360645903139;4327.6970612057485;4328.307470804656;4941.678790878582;4951.430585482643;4971.701697898137;5002.974985125051;5018.096742586369;4176.14389050244;4205.9789701051295;4225.9788701056295;4243.872683819491;4299.280287884871;2587.780038696694;2588.9870550647124;2613.8954441822493;2615.751503607154;2632.2234940692542;4607.262837945979;4645.46577143626;4646.97676511622;4653.581177694024;4653.8371157010015;4912.287718280901;5024.773885175176;5047.823326183566;5064.645474816801;5071.746412679351;4584.426946631671;4587.889570797471;4613.515580864028;4648.721076735406;4652.348671186037;4860.586850117779;4867.5132486751045;4914.557689807934;4931.126172054596;4931.3096166536;4690.607790027043;4759.452662943806;4776.617870570415;4806.711597304173;4818;4554.499005109369;4568.291914753218;4617.6536759742485;4619.815207391666;4633.235516139799;3424.5719285089363;3502.7022703070525;3504.28162226748;3518.0852978225334;3521.559805024372;4820.590249828804;4907.950920490892;4918.311436398835;4929.162042452864;5141.922871156861;4978.556218696683;5000.77496512665;5019.874503137305;5050;5067.797288108434;4951.232558953368;5025.246213067923;5030;5041.168207245763;5048.444671086251;4811.663183577256;4907.288443175791;4923.4584195737725;4962.2880106363245;4967.900641987212;5011.649184557046;5029.692280007152;5030.144875371268;5036.420811606712;5044.772985215601;4888.413390393175;4901.166801643801;4914.238293064581;4915.926261106158;4923.803047878045 07:47:34 INFO - PROCESS | 14392 | |5;yui.html;747.0512449189526;761.4859969520572;768.5772824946279;772.6870617399953;827.2430725885819;12057.939710301447;12533.498660053587;12542.310172940495;12726.427310771014;12783.041271904609;12745.936270318658;12757.553485628005;12829.230246185236;12866.163699359535;13555.322233888292;873.7509809704236;881.7178502879082;882.025361975018;882.5587206396801;882.7219425880859;672.146374104889;847.4237518487427;856.6744637037948;878.7627340618029;882.8719835623831;909.7952960583882;911.4941207629763;911.726482055384;913.5477938420491;913.5797533134765;899.491787140267;901.8286525560155;901.8647202919549;902.1069141549884;902.5442151713409;528.577138289367;543.1011675676762;543.2720154992289;654.6890227142117;674.1943377663645;12648.810267845989;12721.04592155592;12724.936375318157;12734.745305093846;12751.744965100646;11384.772304553946;11750.588729394516;11850.111241656825;11915.94042029793;12118.81821772674;11160.274582152135;11201.159913006557;11272.267302625385;11322;11395.487203075882;3388.542546756206;4086.101057767316;4118.75287482752;4226.746395216297;4237.851675191384;42407.36388954168;44825;44886.32670509945;44957.775211123735;45274;9230.769230769285;9440.197583205367;9515.23878089751;9635.614575417045;9771.4625695586;16871.156442177842;17038.31846726142;17128.914355428144;17212.82787172112;17219.13904304805;6973.58370780379;7063.187733410621;7071.858562828715;7110.7511237106455;7276.381507571809;3835.5780864104927;3844.2888065707934;3908.687305015592;3914.5498267699577;3916.2167566486814;2836.305105249186;2919.868605912739;2927.9707202928125;2928.44359571685;2938.059820857305;532.6165161084014;537.1084000559131;542.8344354971692;543.4049715561533;558.5252535344924;552.6849695673427;572.2760707704757;585.6251998720822;594.5006194796392;624.6751689121631;7711.575863327571;7764.572948487775;8022.59887005659;8030.7262569832865;8075.596220188967;518.5151882989417;524.520064141314;581.7149596697587;595.0806004722714;646.6637348578806;3675.889723308305;3839;3842.423636454554;3946.131850992834;3951.644352008333;50714;51693.22460163101;52211.73894130505;52646;52928.73535632374;46833.29750053752;48264.27603585949;48788.512114878395;48896;49257.26114108291;40449.39325910114;42653;43606;44047;44702.77648611801;8173.713920012771;8272.296854767412;8372.98659628924;8522.872156917776;8573.099824518586;28632.42735145244;28884.566731499464;29520.704792951794;30507;30728.539071913492;36559.45160822537;38715.80642096772;38806;39106.80446597749;39284.410733839584;10054.748631284276;10180.796384072426;10296.485175741333;10434.843477347695;11210.87891210905;11582.536698531965;11873.287602743863;12359.75280494403;12655.367231638565;13037.413316400594;10200.948995254976;11024.724381890517;11108.111351092055;11261.943690281496;11613.6515904523;11441.256318339281;11789.469473873867;11937.28376297425;12067.09496787762;12354.382280886099;10170.644027459004;10477.16182705397;10508.106810921157;10590.152787777113;10590.364578125336;9611.519424028911;9676.612935482503;9772.12050915421;9864.79145589636;10091.142252908585;9870.901290986998;9957.601695932082;9987.750306242402;10056.748581285234;10201.234907381828 07:47:34 INFO - PROCESS | 14392 | __end_tp_report 07:47:34 INFO - PROCESS | 14392 | __start_cc_report 07:47:34 INFO - PROCESS | 14392 | _x_x_mozilla_cycle_collect,1095 07:47:34 INFO - PROCESS | 14392 | __end_cc_report 07:47:34 INFO - PROCESS | 14392 | __startTimestamp1462546054116__endTimestamp 07:47:34 INFO - PROCESS | 14392 | 07:47:34 INFO - PROCESS | 14392 | ------- Summary: start ------- 07:47:34 INFO - PROCESS | 14392 | Number of tests: 6 07:47:34 INFO - PROCESS | 14392 | 07:47:34 INFO - PROCESS | 14392 | [#0] dojo.html Cycles:165 Average:4666.30 Median:4791.59 stddev:477.73 (10.0%) stddev-sans-first:451.52 07:47:34 INFO - PROCESS | 14392 | Values: 2623.6 2644.0 2671.5 2675.9 2685.2 4519.3 4591.5 4630.1 4718.3 4754.6 4648.2 4691.2 4745.4 4756.2 4845.5 4305.5 4320.5 4323.5 4336.4 4449.9 4341.3 4441.2 4465.9 4505.3 4512.8 4218.5 4405.3 4452.8 4458.0 4467.5 4253.1 4284.9 4319.7 4323.7 4330.1 4293.9 4341.1 4357.5 4360.7 4387.3 4428.8 4608.6 4660.0 4680.4 4687.9 4984.1 5067.3 5073.3 5098.6 5151.3 5102.9 5141.3 5151.2 5164.7 5171.9 4596.3 4634.3 4818.2 4827.4 4828.9 5090.2 5100.2 5173.8 5174.1 5176.3 4895.9 4914.0 4920.5 4986.1 4997.2 4870.5 4966.0 5005.1 5011.3 5015.8 4961.1 4980.2 4983.7 4986.2 5020.0 4965.3 4967.6 4969.1 4970.9 5009.1 4202.7 4246.3 4285.0 4321.7 4333.8 3761.8 3763.7 3806.0 3816.7 3863.2 4331.3 4333.4 4341.4 4375.6 4383.5 4845.1 5051.2 5058.9 5108.9 5114.1 4379.5 4406.4 4408.9 4410.3 4452.0 4638.9 4649.8 4650.9 4655.8 4705.3 4528.2 4693.3 4740.6 4743.2 4769.7 5071.4 5076.3 5084.2 5094.7 5146.4 4562.0 4748.4 4761.0 4761.1 4814.1 4967.3 4971.5 5012.5 5023.6 5037.8 5051.7 5067.1 5067.1 5086.9 5148.2 4690.4 4795.1 4898.2 4913.4 4968.3 4829.3 4838.6 4862.8 4867.1 4908.9 4791.6 4799.3 4840.5 4891.6 4891.8 4754.9 4930.5 4954.3 4993.5 5005.1 4798.4 4839.4 4869.1 4911.6 4921.2 07:47:34 INFO - PROCESS | 14392 | 07:47:34 INFO - PROCESS | 14392 | [#1] ext.html Cycles:180 Average:55110.83 Median:36852.95 stddev:126190.01 (342.4%) stddev-sans-first:126477.52 07:47:34 INFO - PROCESS | 14392 | Values: 553.7 595.5 598.6 608.2 611.8 41871.8 42970.4 43003.8 47433.0 47548.5 43616.8 43729.6 44109.6 44117.1 44176.3 8002.7 8108.3 8118.3 8118.6 8123.1 7918.2 7934.9 7960.4 8004.2 8038.0 8095.6 8134.3 8134.8 8135.1 8141.1 8037.7 8041.3 8063.4 8073.1 8086.4 8048.6 8108.8 8111.6 8115.1 8121.4 40298.6 40630.6 40651.4 40696.8 40723.8 3252.8 3299.3 3356.7 3448.5 3603.0 29952.0 30223.2 30226.2 30299.7 30465.0 3374.2 3383.1 3445.7 3458.6 3552.3 260033.0 260492.7 261411.0 261611.0 261690.0 34181.5 34715.7 57955.7 58197.1 58670.4 34258.7 34312.5 34364.5 34371.8 34392.0 14248.8 14478.3 14482.3 14484.6 14485.6 11585.8 11774.9 11793.6 11804.5 11807.5 8333.5 8359.0 8421.0 8476.9 8488.8 3233.7 3274.3 3288.8 3300.6 3313.5 907.1 946.7 974.4 1003.6 1042.1 29353.3 29466.3 29528.4 30143.5 30203.0 1026.3 1064.4 1070.2 1086.7 1100.0 15161.2 15558.4 15640.0 15847.3 15852.5 380818.0 752733.0 775455.0 775593.0 776363.0 52060.3 52297.5 52883.0 52917.2 52953.7 1173.7 1293.3 1298.4 1317.4 1333.1 27770.3 30075.2 30258.8 30648.4 30721.2 44430.8 44653.3 45075.5 45097.0 45118.5 283285.0 284616.0 285991.0 286284.0 286892.0 23549.3 26364.5 26723.9 26780.6 26804.0 42912.1 43369.0 43497.3 44124.6 44719.6 36701.3 37559.4 37632.2 37993.2 38282.2 36597.3 37300.0 37307.4 37583.4 37893.2 37004.6 37276.8 38752.8 39445.2 39568.4 30878.4 33054.8 33217.8 33422.0 33659.0 24683.1 25059.6 25169.9 25347.6 25577.5 07:47:34 INFO - PROCESS | 14392 | 07:47:34 INFO - PROCESS | 14392 | [#2] jquery.html Cycles:180 Average:20108.81 Median:46309.65 stddev:49244.92 (106.3%) stddev-sans-first:49360.76 07:47:34 INFO - PROCESS | 14392 | Values: 369.1 373.3 376.0 382.3 391.4 16179.5 17541.3 17586.6 17856.6 18048.3 11223.7 16288.0 17011.5 17077.5 17467.8 4685.5 4797.5 4816.0 4851.3 4851.4 3377.9 4776.4 5244.0 5500.9 5534.3 5597.1 5602.9 5627.9 5629.4 5636.6 5364.7 5514.8 5525.9 5564.5 5572.6 3328.6 4943.9 5222.6 5225.8 5291.0 12401.1 12406.4 12476.9 12594.5 12635.6 1977.6 1981.0 2043.1 2077.6 2129.2 8885.0 9325.3 9526.5 9555.1 9694.3 1782.8 1788.3 1814.8 1845.9 1889.7 66241.3 66735.0 67007.3 67784.7 68301.7 8269.2 8867.7 8909.2 9392.2 9458.0 12363.1 12366.3 12426.8 12426.9 12427.4 7247.7 7256.7 7269.0 7483.5 7515.8 7383.2 7435.4 7523.8 7529.8 7552.1 3850.5 3874.5 3911.0 3943.7 3963.7 1743.7 1775.5 1833.9 1851.4 1872.7 875.0 892.0 941.8 955.8 968.7 16838.1 17121.8 17278.2 17481.2 17776.8 893.7 909.3 921.4 929.0 931.6 9496.4 9573.2 9650.6 9718.6 9916.7 142817.0 143473.0 253245.7 400620.0 406390.0 46225.8 46393.5 75332.0 78679.6 81963.0 949.7 986.2 1003.3 1006.6 1014.9 15917.3 15924.4 15959.8 16063.1 16466.8 29002.0 31893.4 35471.3 35566.0 35766.5 44239.3 46210.8 49710.0 51502.7 52134.0 7497.7 7552.7 7592.1 7616.5 7659.0 9379.8 11404.8 11644.5 11883.3 11938.8 6681.0 10096.3 10364.0 10380.2 10417.9 8654.8 9212.4 9461.9 9730.0 9838.8 10450.1 10515.0 10588.8 10690.6 10721.5 7718.1 7736.6 7820.0 7970.7 7987.2 10196.6 10292.2 10292.3 10349.9 10371.2 07:47:34 INFO - PROCESS | 14392 | 07:47:34 INFO - PROCESS | 14392 | [#3] mootools.html Cycles:180 Average:4998.68 Median:5027.38 stddev:2767.04 (55.0%) stddev-sans-first:2760.85 07:47:34 INFO - PROCESS | 14392 | Values: 1301.1 1508.7 1544.9 1627.0 1796.4 7135.1 7344.1 7357.5 7529.4 7538.7 7394.7 7562.5 7575.2 7578.4 7585.2 1897.7 1961.5 1963.5 2178.4 2214.7 2193.8 2252.3 2253.8 2262.1 2264.3 2156.8 2166.5 2185.2 2189.8 2198.8 1841.4 2119.7 2148.1 2149.3 2158.5 2122.9 2142.4 2145.0 2148.3 2151.0 7559.7 7599.4 7609.5 7612.7 7615.2 4389.9 4482.6 4510.3 4547.2 4553.4 2633.1 2730.2 2750.0 2754.4 2757.9 839.9 883.4 895.9 1658.1 1719.3 9967.3 9994.2 10134.3 10136.0 10142.4 3982.0 4035.2 4088.9 4113.1 4114.0 8062.9 8104.7 8139.5 8143.9 8145.1 4459.1 4459.5 4465.5 4469.7 4472.4 3611.9 3975.4 4092.4 4152.1 4179.5 3419.7 3466.6 3485.6 3501.3 3563.7 1036.6 1038.1 1041.4 1047.5 1072.1 871.9 889.9 891.6 897.8 902.1 5179.8 5225.9 5325.7 5368.1 5394.7 392.7 410.1 411.9 411.9 417.7 3638.3 3651.3 3702.7 3748.9 3758.3 9006.7 9372.1 9427.4 9537.9 9589.0 9419.7 9495.1 9515.1 9528.1 9532.6 7086.2 7184.6 7277.8 7373.0 7380.1 4941.4 5087.4 5161.4 5204.3 5205.9 8524.0 8529.9 8650.5 8822.1 8868.7 8801.7 8809.5 8903.2 8944.9 9034.0 5574.2 5733.1 5737.7 6289.4 6360.6 6903.9 6965.9 7061.0 7314.3 7343.4 6524.3 6774.4 6847.5 6864.9 6939.3 6588.0 6602.2 6635.8 6673.3 6713.3 6326.6 6366.7 6392.3 6402.6 6404.1 4502.7 4614.9 4653.3 4689.8 4706.0 4776.7 4823.0 4847.1 4877.7 4967.4 07:47:34 INFO - PROCESS | 14392 | 07:47:34 INFO - PROCESS | 14392 | [#4] prototype.html Cycles:180 Average:4087.54 Median:4597.58 stddev:1172.84 (25.5%) stddev-sans-first:1141.10 07:47:34 INFO - PROCESS | 14392 | Values: 296.8 297.1 303.3 308.9 309.6 4781.3 4808.0 4830.7 4856.5 4860.8 4502.5 4547.6 4664.8 4682.5 4771.9 3730.2 3748.5 3754.4 3763.7 3764.6 3734.8 3749.6 3751.6 3765.4 3772.3 3529.8 3625.5 3714.8 3742.7 3744.9 3684.5 3686.0 3721.2 3727.7 3741.1 3302.7 3307.6 3317.3 3328.8 3345.0 4370.1 4485.0 4520.3 4547.6 4572.3 4214.8 4233.4 4266.6 4268.0 4290.1 4885.5 4905.5 4918.2 4928.5 4972.9 3625.6 3626.3 3638.3 3648.6 3656.4 4961.5 5145.8 5164.4 5166.6 5180.4 3676.8 3678.9 3685.1 3699.4 3740.4 3753.3 3770.6 3774.1 3794.5 3794.8 4019.3 4183.3 4224.3 4224.9 4289.7 4979.5 5003.5 5018.7 5027.9 5038.9 1170.7 1205.6 1249.6 1254.3 1257.2 842.2 855.2 860.0 860.2 861.5 4227.3 4234.7 4262.4 4327.7 4328.3 4941.7 4951.4 4971.7 5003.0 5018.1 4176.1 4206.0 4226.0 4243.9 4299.3 2587.8 2589.0 2613.9 2615.8 2632.2 4607.3 4645.5 4647.0 4653.6 4653.8 4912.3 5024.8 5047.8 5064.6 5071.7 4584.4 4587.9 4613.5 4648.7 4652.3 4860.6 4867.5 4914.6 4931.1 4931.3 4690.6 4759.5 4776.6 4806.7 4818.0 4554.5 4568.3 4617.7 4619.8 4633.2 3424.6 3502.7 3504.3 3518.1 3521.6 4820.6 4908.0 4918.3 4929.2 5141.9 4978.6 5000.8 5019.9 5050.0 5067.8 4951.2 5025.2 5030.0 5041.2 5048.4 4811.7 4907.3 4923.5 4962.3 4967.9 5011.6 5029.7 5030.1 5036.4 5044.8 4888.4 4901.2 4914.2 4915.9 4923.8 07:47:34 INFO - PROCESS | 14392 | 07:47:34 INFO - PROCESS | 14392 | [#5] yui.html Cycles:180 Average:12907.51 Median:43129.50 stddev:14440.70 (33.5%) stddev-sans-first:14452.33 07:47:34 INFO - PROCESS | 14392 | Values: 747.1 761.5 768.6 772.7 827.2 12057.9 12533.5 12542.3 12726.4 12783.0 12745.9 12757.6 12829.2 12866.2 13555.3 873.8 881.7 882.0 882.6 882.7 672.1 847.4 856.7 878.8 882.9 909.8 911.5 911.7 913.5 913.6 899.5 901.8 901.9 902.1 902.5 528.6 543.1 543.3 654.7 674.2 12648.8 12721.0 12724.9 12734.7 12751.7 11384.8 11750.6 11850.1 11915.9 12118.8 11160.3 11201.2 11272.3 11322.0 11395.5 3388.5 4086.1 4118.8 4226.7 4237.9 42407.4 44825.0 44886.3 44957.8 45274.0 9230.8 9440.2 9515.2 9635.6 9771.5 16871.2 17038.3 17128.9 17212.8 17219.1 6973.6 7063.2 7071.9 7110.8 7276.4 3835.6 3844.3 3908.7 3914.5 3916.2 2836.3 2919.9 2928.0 2928.4 2938.1 532.6 537.1 542.8 543.4 558.5 552.7 572.3 585.6 594.5 624.7 7711.6 7764.6 8022.6 8030.7 8075.6 518.5 524.5 581.7 595.1 646.7 3675.9 3839.0 3842.4 3946.1 3951.6 50714.0 51693.2 52211.7 52646.0 52928.7 46833.3 48264.3 48788.5 48896.0 49257.3 40449.4 42653.0 43606.0 44047.0 44702.8 8173.7 8272.3 8373.0 8522.9 8573.1 28632.4 28884.6 29520.7 30507.0 30728.5 36559.5 38715.8 38806.0 39106.8 39284.4 10054.7 10180.8 10296.5 10434.8 11210.9 11582.5 11873.3 12359.8 12655.4 13037.4 10200.9 11024.7 11108.1 11261.9 11613.7 11441.3 11789.5 11937.3 12067.1 12354.4 10170.6 10477.2 10508.1 10590.2 10590.4 9611.5 9676.6 9772.1 9864.8 10091.1 9870.9 9957.6 9987.8 10056.7 10201.2 07:47:34 INFO - PROCESS | 14392 | -------- Summary: end -------- 07:47:34 INFO - PROCESS | 14392 | 07:47:34 INFO - TEST-INFO | 14392: exit 0 07:47:34 INFO - TEST-OK | dromaeo_css | took 1119197ms 07:47:34 INFO - TEST-START | kraken 07:47:34 INFO - operating with platform_type : linux_ 07:47:34 INFO - Initialising browser for kraken test... 07:47:34 INFO - TEST-INFO | started process 14572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprQzyyv/profile http://localhost:34996/getInfo.html) 07:47:39 INFO - PROCESS | 14572 | __metrics Screen width/height:1600/1200 07:47:39 INFO - PROCESS | 14572 | colorDepth:24 07:47:39 INFO - PROCESS | 14572 | Browser inner width/height: 1024/697 07:47:39 INFO - PROCESS | 14572 | __metrics 07:47:40 ERROR - PROCESS | 14572 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:47:41 INFO - TEST-INFO | 14572: exit 0 07:47:41 INFO - Browser initialized. 07:47:41 INFO - Running cycle 1/1 for kraken test... 07:47:41 INFO - TEST-INFO | started process 14653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprQzyyv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:53 INFO - PROCESS | 14653 | RSS: Main: 154140672 07:47:53 INFO - PROCESS | 14653 | 07:47:55 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:34996/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34996/tests/kraken/driver.html?testName=audio-beat-detection) 07:47:56 INFO - PROCESS | 14653 | RSS: Main: 210722816 07:47:56 INFO - PROCESS | 14653 | 07:47:59 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:34996/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34996/tests/kraken/driver.html?testName=audio-dft) 07:48:00 INFO - PROCESS | 14653 | RSS: Main: 198811648 07:48:00 INFO - PROCESS | 14653 | 07:48:03 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:34996/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34996/tests/kraken/driver.html?testName=audio-fft) 07:48:04 INFO - PROCESS | 14653 | RSS: Main: 267108352 07:48:04 INFO - PROCESS | 14653 | 07:48:06 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:34996/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34996/tests/kraken/driver.html?testName=audio-oscillator) 07:48:06 INFO - PROCESS | 14653 | RSS: Main: 176574464 07:48:06 INFO - PROCESS | 14653 | 07:48:09 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:34996/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34996/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:48:09 INFO - PROCESS | 14653 | RSS: Main: 179712000 07:48:09 INFO - PROCESS | 14653 | 07:48:12 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:34996/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34996/tests/kraken/driver.html?testName=imaging-darkroom) 07:48:13 INFO - PROCESS | 14653 | RSS: Main: 215805952 07:48:13 INFO - PROCESS | 14653 | 07:48:16 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:34996/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34996/tests/kraken/driver.html?testName=imaging-desaturate) 07:48:17 INFO - PROCESS | 14653 | RSS: Main: 216195072 07:48:17 INFO - PROCESS | 14653 | 07:48:20 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:34996/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34996/tests/kraken/driver.html?testName=json-parse-financial) 07:48:21 INFO - PROCESS | 14653 | RSS: Main: 216686592 07:48:21 INFO - PROCESS | 14653 | 07:48:22 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:34996/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34996/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:48:23 INFO - PROCESS | 14653 | RSS: Main: 203972608 07:48:23 INFO - PROCESS | 14653 | 07:48:25 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:34996/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34996/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:48:25 INFO - PROCESS | 14653 | RSS: Main: 208695296 07:48:25 INFO - PROCESS | 14653 | 07:48:27 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:34996/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34996/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:48:28 INFO - PROCESS | 14653 | RSS: Main: 219074560 07:48:28 INFO - PROCESS | 14653 | 07:48:31 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:34996/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:48:32 INFO - PROCESS | 14653 | RSS: Main: 225636352 07:48:32 INFO - PROCESS | 14653 | 07:48:34 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:34996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:48:35 INFO - PROCESS | 14653 | RSS: Main: 220057600 07:48:35 INFO - PROCESS | 14653 | 07:48:37 INFO - PROCESS | 14653 | Cycle 1(1): loaded http://localhost:34996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34996/tests/kraken/driver.html?testName=ai-astar) 07:48:37 INFO - PROCESS | 14653 | RSS: Main: 264966144 07:48:37 INFO - PROCESS | 14653 | 07:48:37 INFO - PROCESS | 14653 | __start_tp_report 07:48:37 INFO - PROCESS | 14653 | _x_x_mozilla_page_load 07:48:37 INFO - PROCESS | 14653 | _x_x_mozilla_page_load_details 07:48:37 INFO - PROCESS | 14653 | |i|pagename|runs| 07:48:37 INFO - PROCESS | 14653 | |0;ai-astar;113;108;112;112;114;112;112;113;112;114 07:48:37 INFO - PROCESS | 14653 | |1;audio-beat-detection;158;129;159;203;132;153;157;131;202;131 07:48:37 INFO - PROCESS | 14653 | |2;audio-dft;161;162;162;161;163;161;161;162;161;161 07:48:37 INFO - PROCESS | 14653 | |3;audio-fft;75;75;77;126;76;75;77;76;142;75 07:48:37 INFO - PROCESS | 14653 | |4;audio-oscillator;93;94;118;92;93;95;126;93;93;130 07:48:37 INFO - PROCESS | 14653 | |5;imaging-gaussian-blur;116;117;117;118;117;117;117;117;116;117 07:48:37 INFO - PROCESS | 14653 | |6;imaging-darkroom;147;146;146;146;147;147;146;145;147;146 07:48:37 INFO - PROCESS | 14653 | |7;imaging-desaturate;95;94;94;95;98;95;95;96;94;95 07:48:37 INFO - PROCESS | 14653 | |8;json-parse-financial;65;65;66;66;65;66;67;86;64;64 07:48:37 INFO - PROCESS | 14653 | |9;json-stringify-tinderbox;63;64;64;64;64;65;64;63;65;65 07:48:37 INFO - PROCESS | 14653 | |10;stanford-crypto-aes;82;82;83;82;84;84;83;83;83;84 07:48:37 INFO - PROCESS | 14653 | |11;stanford-crypto-ccm;147;133;131;136;131;128;130;131;169;133 07:48:37 INFO - PROCESS | 14653 | |12;stanford-crypto-pbkdf2;177;172;185;170;173;179;177;172;174;170 07:48:37 INFO - PROCESS | 14653 | |13;stanford-crypto-sha256-iterative;68;67;67;69;67;68;70;66;70;67 07:48:37 INFO - PROCESS | 14653 | __end_tp_report 07:48:37 INFO - PROCESS | 14653 | __start_cc_report 07:48:37 INFO - PROCESS | 14653 | _x_x_mozilla_cycle_collect,1862 07:48:37 INFO - PROCESS | 14653 | __end_cc_report 07:48:37 INFO - PROCESS | 14653 | __startTimestamp1462546117611__endTimestamp 07:48:37 INFO - PROCESS | 14653 | 07:48:37 INFO - PROCESS | 14653 | ------- Summary: start ------- 07:48:37 INFO - PROCESS | 14653 | Number of tests: 14 07:48:37 INFO - PROCESS | 14653 | 07:48:37 INFO - PROCESS | 14653 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.50 stddev:1.69 (1.5%) stddev-sans-first:1.76 07:48:37 INFO - PROCESS | 14653 | Values: 113.0 108.0 112.0 112.0 114.0 112.0 112.0 113.0 112.0 114.0 07:48:37 INFO - PROCESS | 14653 | 07:48:37 INFO - PROCESS | 14653 | [#1] audio-beat-detection Cycles:10 Average:155.50 Median:157.50 stddev:27.69 (17.6%) stddev-sans-first:29.35 07:48:37 INFO - PROCESS | 14653 | Values: 158.0 129.0 159.0 203.0 132.0 153.0 157.0 131.0 202.0 131.0 07:48:37 INFO - PROCESS | 14653 | 07:48:37 INFO - PROCESS | 14653 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 07:48:37 INFO - PROCESS | 14653 | Values: 161.0 162.0 162.0 161.0 163.0 161.0 161.0 162.0 161.0 161.0 07:48:37 INFO - PROCESS | 14653 | 07:48:37 INFO - PROCESS | 14653 | [#3] audio-fft Cycles:10 Average:87.40 Median:75.50 stddev:24.86 (32.9%) stddev-sans-first:25.96 07:48:37 INFO - PROCESS | 14653 | Values: 75.0 75.0 77.0 126.0 76.0 75.0 77.0 76.0 142.0 75.0 07:48:37 INFO - PROCESS | 14653 | 07:48:37 INFO - PROCESS | 14653 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:93.00 stddev:15.45 (16.6%) stddev-sans-first:15.98 07:48:37 INFO - PROCESS | 14653 | Values: 93.0 94.0 118.0 92.0 93.0 95.0 126.0 93.0 93.0 130.0 07:48:37 INFO - PROCESS | 14653 | 07:48:37 INFO - PROCESS | 14653 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 07:48:37 INFO - PROCESS | 14653 | Values: 116.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 07:48:37 INFO - PROCESS | 14653 | 07:48:37 INFO - PROCESS | 14653 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 07:48:37 INFO - PROCESS | 14653 | Values: 147.0 146.0 146.0 146.0 147.0 147.0 146.0 145.0 147.0 146.0 07:48:37 INFO - PROCESS | 14653 | 07:48:37 INFO - PROCESS | 14653 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:1.20 (1.3%) stddev-sans-first:1.27 07:48:37 INFO - PROCESS | 14653 | Values: 95.0 94.0 94.0 95.0 98.0 95.0 95.0 96.0 94.0 95.0 07:48:37 INFO - PROCESS | 14653 | 07:48:37 INFO - PROCESS | 14653 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:66.00 stddev:6.60 (10.0%) stddev-sans-first:6.95 07:48:37 INFO - PROCESS | 14653 | Values: 65.0 65.0 66.0 66.0 65.0 66.0 67.0 86.0 64.0 64.0 07:48:37 INFO - PROCESS | 14653 | 07:48:37 INFO - PROCESS | 14653 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 07:48:37 INFO - PROCESS | 14653 | Values: 63.0 64.0 64.0 64.0 64.0 65.0 64.0 63.0 65.0 65.0 07:48:37 INFO - PROCESS | 14653 | 07:48:37 INFO - PROCESS | 14653 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:0.82 (1.0%) stddev-sans-first:0.78 07:48:37 INFO - PROCESS | 14653 | Values: 82.0 82.0 83.0 82.0 84.0 84.0 83.0 83.0 83.0 84.0 07:48:37 INFO - PROCESS | 14653 | 07:48:37 INFO - PROCESS | 14653 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:133.00 stddev:12.45 (9.4%) stddev-sans-first:12.66 07:48:37 INFO - PROCESS | 14653 | Values: 147.0 133.0 131.0 136.0 131.0 128.0 130.0 131.0 169.0 133.0 07:48:37 INFO - PROCESS | 14653 | 07:48:37 INFO - PROCESS | 14653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:175.50 stddev:4.68 (2.7%) stddev-sans-first:4.90 07:48:37 INFO - PROCESS | 14653 | Values: 177.0 172.0 185.0 170.0 173.0 179.0 177.0 172.0 174.0 170.0 07:48:37 INFO - PROCESS | 14653 | 07:48:37 INFO - PROCESS | 14653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.37 (2.0%) stddev-sans-first:1.45 07:48:37 INFO - PROCESS | 14653 | Values: 68.0 67.0 67.0 69.0 67.0 68.0 70.0 66.0 70.0 67.0 07:48:37 INFO - PROCESS | 14653 | -------- Summary: end -------- 07:48:37 INFO - PROCESS | 14653 | 07:48:38 INFO - TEST-INFO | 14653: exit 0 07:48:38 INFO - TEST-OK | kraken | took 63870ms 07:48:38 INFO - SUITE-END | took 1183s 07:48:38 INFO - Completed test suite (00:19:43) 07:48:38 INFO - javascript benchmark 07:48:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.6195751616015, 2643.9867800660995, 2671.4790615829907, 2675.8528280944543, 2685.2347081081894, 4519.27691569349, 4591.517890621479, 4630.097131059445, 4718.315844202589, 4754.572088512034, 4648.23304154814, 4691.2024955757515, 4745.3593764841735, 4756.191447453933, 4845.491223421543, 4305.526392096866, 4320.546342634026, 4323.502797178333, 4336.3712261722185, 4449.911001779962, 4341.28368819146, 4441.178381999324, 4465.933011004838, 4505.279155335147, 4512.751798651073, 4218.514870789868, 4405.251107311765, 4452.7996240169105, 4458.019235768126, 4467.508574056851, 4253.128108737701, 4284.871453856389, 4319.719218250835, 4323.718958267703, 4330.069035157425, 4293.892652683677, 4341.088371442001, 4357.477102747691, 4360.65114790816, 4387.254166791653, 4428.844990425319, 4608.585227329523, 4660.04469083837, 4680.4149481314835, 4687.859364219079, 4984.077945580043, 5067.315912351823, 5073.2643766654, 5098.59211263098, 5151.304573882516, 5102.872428189288, 5141.2545180948555, 5151.201563757623, 5164.715940623264, 5171.948280517185, 4596.264597664424, 4634.2585186370015, 4818.180909245367, 4827.372441582607, 4828.855134345975, 5090.2364645303505, 5100.209467532539, 5173.767180476888, 5174.120399532088, 5176.275321454999, 4895.926561101586, 4914.0, 4920.532549407801, 4986.102501549683, 4997.225430058346, 4870.537298956593, 4965.9751701241985, 5005.074061298671, 5011.273365362002, 5015.84952451427, 4961.05739909416, 4980.178270585386, 4983.651144419856, 4986.152354099811, 5019.974900125476, 4965.255211718199, 4967.552920237196, 4969.055879382906, 4970.925436118461, 5009.073321435546, 4202.705810593229, 4246.299360605527, 4284.957150428519, 4321.67587430944, 4333.804978775963, 3761.8119094045187, 3763.7365384423374, 3806.0294624871035, 3816.656500914931, 3863.150106976461, 4331.306990881444, 4333.43665323506, 4341.39220509129, 4375.606195442362, 4383.539728328479, 4845.079434907357, 5051.217061355495, 5058.949410505921, 5108.923366149511, 5114.0539000284325, 4379.5182529921685, 4406.405135306757, 4408.933865992013, 4410.272305069628, 4452.0, 4638.8608341749805, 4649.837255696035, 4650.883727906762, 4655.767211639472, 4705.294205869079, 4528.184926713157, 4693.319468677091, 4740.6444516660695, 4743.169945259497, 4769.73766442849, 5071.4421413645205, 5076.314697515788, 5084.161113416393, 5094.719790411563, 5146.408163061295, 4562.041971186088, 4748.358971538798, 4761.047790441856, 4761.071591039714, 4814.133455977958, 4967.254911763264, 4971.477994810492, 5012.498750124958, 5023.598112151092, 5037.7733002014265, 5051.74741262928, 5067.062593420229, 5067.062593420229, 5086.872828179326, 5148.176291793295, 4690.366800481891, 4795.064962332312, 4898.167311557115, 4913.385826771653, 4968.329275547755, 4829.27560865873, 4838.637102217418, 4862.805487780591, 4867.14824905633, 4908.92636610444, 4791.592714619296, 4799.28010798383, 4840.54014868601, 4891.559759621651, 4891.755412229445, 4754.857354279239, 4930.5069493050405, 4954.256861470808, 4993.450720420823, 5005.074061298671, 4798.376211092535, 4839.395075615548, 4869.074875773592, 4911.63162762787, 4921.163402221559], "value": 4636.689147920187, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.6927005511942, 595.5444085274765, 598.5959477352787, 608.2275510102173, 611.8164550634808, 41871.79064104679, 42970.35544466832, 43003.78498107509, 47433.0, 47548.52451475484, 43616.781916090455, 43729.56270437295, 44109.558904410944, 44117.11765764683, 44176.3373549397, 8002.679892804281, 8108.310793582553, 8118.309943654796, 8118.553479558622, 8123.065847427532, 7918.168592297812, 7934.880976785353, 7960.40296977729, 8004.159563245863, 8038.0, 8095.55474448908, 8134.308583770387, 8134.796630084265, 8135.145809689957, 8141.145179756129, 8037.718679846206, 8041.276285134366, 8063.435559510836, 8073.1119576846795, 8086.353091752646, 8048.59757012147, 8108.797280067986, 8111.594420278962, 8115.066767321775, 8121.431499795017, 40298.59701402978, 40630.593694063275, 40651.390229146586, 40696.79651601723, 40723.796381018205, 3252.8210948397827, 3299.340131973591, 3356.748243881694, 3448.499967504698, 3602.981985090084, 29952.0, 30223.244418889484, 30226.244343891358, 30299.69700302991, 30465.0, 3374.190194353362, 3383.069655844638, 3445.672661097192, 3458.56767904012, 3552.342816578941, 260033.0, 260492.697536513, 261411.0, 261611.0, 261690.0, 34181.48727769085, 34715.65284347175, 57955.71022144862, 58197.127043094384, 58670.41329586735, 34258.657413426045, 34312.48531272033, 34364.48453273203, 34371.828140859136, 34392.0, 14248.786268205986, 14478.348474318682, 14482.34829432678, 14484.565463036126, 14485.637859053608, 11585.826212606818, 11774.94112529432, 11793.587224447103, 11804.527818887149, 11807.527698891949, 8333.499990000499, 8359.038710548242, 8421.0, 8476.915230847735, 8488.83022339562, 3233.692799184074, 3274.3287626036604, 3288.8355582220793, 3300.603927528712, 3313.5029745538363, 907.0905743410159, 946.6875930942772, 974.3715303629261, 1003.5985605757755, 1042.0881728487423, 29353.266168345963, 29466.263343416158, 29528.409431811673, 30143.547846782316, 30203.0, 1026.2559644257854, 1064.3720205078885, 1070.2347821307803, 1086.7174534621056, 1100.0374672161859, 15161.241937903062, 15558.377664893504, 15640.0, 15847.286872090783, 15852.52442426729, 380818.0, 752733.0, 775455.0, 775593.0, 776363.0, 52060.31457168873, 52297.47702523002, 52883.0, 52917.20624190563, 52953.7352313236, 1173.7417768091007, 1293.2822283632486, 1298.4222021200476, 1317.4466723975954, 1333.1467860569244, 27770.305742356602, 30075.24811879633, 30258.84870575721, 30648.387032259678, 30721.231969200948, 44430.77784611056, 44653.330200046374, 45075.549244508446, 45097.0, 45118.548814511436, 283285.0, 284616.0, 285991.0, 286284.0, 286892.0, 23549.29352119439, 26364.472710546066, 26723.866380667972, 26780.59829102604, 26804.0, 42912.141757164056, 43369.0, 43497.34753978756, 44124.55875441204, 44719.55280447154, 36701.26597467982, 37559.43660845035, 37632.247355053296, 37993.240135197695, 38282.23435531218, 36597.268054638225, 37300.0, 37307.44038839474, 37583.43624845684, 37893.24213515769, 37004.629953701195, 37276.813615931744, 38752.806235969765, 39445.2110957785, 39568.40647390349, 30878.38243235168, 33054.834725826215, 33217.83391083029, 33422.0, 33659.0, 24683.136090236756, 25059.624105638064, 25169.87415062986, 25347.61978570286, 25577.488450230518], "value": 17459.678352077564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.1417454418476, 373.2832960715426, 375.9680427163691, 382.32901258291696, 391.3952942703523, 16179.514614561553, 17541.298348066095, 17586.648267034667, 17856.553586160353, 18048.278068877262, 11223.719407014829, 16288.0, 17011.489655310328, 17077.487675369728, 17467.777255592082, 4685.531446855304, 4797.496262892399, 4816.036792641468, 4851.296561998508, 4851.442084160331, 3377.8986630401128, 4776.4268287805335, 5243.973780131113, 5500.917486237709, 5534.252875861747, 5597.076482380402, 5602.887942241153, 5627.943720562783, 5629.408912064236, 5636.605437619368, 5364.704941228231, 5514.80698175566, 5525.861853453655, 5564.4713752193675, 5572.60991730581, 3328.5839270091237, 4943.9258411123865, 5222.608304377149, 5225.843224703265, 5291.0, 12401.13192076555, 12406.441710122976, 12476.875231247663, 12594.496220151183, 12635.620931372074, 1977.6341376845187, 1981.0094952523739, 2043.0601923115385, 2077.6052550015447, 2129.169623846701, 8885.0, 9325.253979681609, 9526.476043817587, 9555.092266234697, 9694.321397502177, 1782.7949785774672, 1788.2668106076446, 1814.7822261328593, 1845.9077046147772, 1889.7070954002152, 66241.33758662448, 66735.0, 67007.32992670109, 67784.6610766943, 68301.65849170722, 8269.21442462965, 8867.73396798097, 8909.242714369351, 9392.248620110375, 9458.0, 12363.134580579273, 12366.319852408204, 12426.75146497083, 12426.937865310616, 12427.37863106841, 7247.658999184799, 7256.7097316106765, 7268.96365518169, 7483.4761566690895, 7515.812104697427, 7383.187849336568, 7435.367993720594, 7523.8495230095095, 7529.832875904243, 7552.093748750185, 3850.4609354690365, 3874.4575759393706, 3910.980445097813, 3943.684505239574, 3963.6630886374405, 1743.6599863026588, 1775.520609435471, 1833.871628985985, 1851.3797877711118, 1872.6816441205028, 874.9562521874008, 892.0187793427178, 941.8069295794346, 955.7897262602216, 968.660968660963, 16838.073905935293, 17121.828781712273, 17278.22247998818, 17481.213345399232, 17776.822231777776, 893.6872094766779, 909.2816674826945, 921.3504479342182, 929.0338048429693, 931.6366617019368, 9496.382735122195, 9573.18627916621, 9650.565724542412, 9718.562664680107, 9916.652917147865, 142817.0, 143473.0, 253245.73377132998, 400620.0, 406390.0, 46225.7688711561, 46393.53606463892, 75332.0, 78679.60660196662, 81963.0, 949.7008442340779, 986.2159583131571, 1003.2626019875386, 1006.5772375602264, 1014.9391036537831, 15917.317299350936, 15924.442644507386, 15959.760603590723, 16063.11652859104, 16466.83533164701, 29002.0, 31893.36213275768, 35471.29057418786, 35566.0, 35766.463503048, 44239.336409953234, 46210.768946155054, 49710.0, 51502.74248628733, 52134.0, 7497.737579184703, 7552.735654252295, 7592.050993625797, 7616.543007419573, 7659.0, 9379.765505862408, 11404.771904561696, 11644.486216791764, 11883.346415947206, 11938.820917686415, 6680.966595166993, 10096.34373765703, 10364.03083414149, 10380.221483388927, 10417.9479102604, 8654.78363040929, 9212.447253164832, 9461.858072129062, 9730.0, 9838.75403114928, 10450.111740502143, 10515.0, 10588.788224235319, 10690.62582809598, 10721.463926803473, 7718.112417072109, 7736.627148166981, 7820.0, 7970.721024764105, 7987.161348058603, 10196.643117490852, 10292.228082893664, 10292.330998485075, 10349.896501034893, 10371.170306375321], "value": 7895.152735342513, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.0632344711805, 1508.6530098077442, 1544.89185756997, 1626.967460650787, 1796.37127005548, 7135.143782746071, 7344.081989751281, 7357.521761085526, 7529.3976481881455, 7538.698452061924, 7394.704211831534, 7562.508436951594, 7575.166731659527, 7578.3558397536135, 7585.241475852412, 1897.7153426985994, 1961.5292329840806, 1963.4600484866705, 2178.400939741572, 2214.734231892175, 2193.846430749848, 2252.3468194223656, 2253.785890340423, 2262.1177740681146, 2264.33202205349, 2156.762756096828, 2166.490874644457, 2185.2024011235944, 2189.8029177374033, 2198.7801219878043, 1841.4107485604611, 2119.73503312086, 2148.0977989244557, 2149.3337065509663, 2158.4927542027613, 2122.862013969087, 2142.389419015589, 2144.957100857974, 2148.291063948893, 2151.0, 7559.659815308324, 7599.392048636096, 7609.505382150142, 7612.695492180306, 7615.238476152396, 4389.890252743675, 4482.574155455227, 4510.300903359985, 4547.18150732868, 4553.362529245908, 2633.0784225521106, 2730.235534050449, 2750.0, 2754.394033312668, 2757.889684412621, 839.9244068033906, 883.3904605821963, 895.892492900856, 1658.1211957662458, 1719.2950890134985, 9967.252456065751, 9994.200463962865, 10134.290599658027, 10136.037076477724, 10142.442165680885, 3982.0443093657314, 4035.1929614076716, 4088.897777555585, 4113.053997580573, 4113.958860411418, 8062.879056814152, 8104.675812967534, 8139.4709343892455, 8143.918560814434, 8145.144759800254, 4459.108178364275, 4459.531749166291, 4465.508794032654, 4469.687121901501, 4472.44094488189, 3611.8735844245325, 3975.4434379186937, 4092.4475195848777, 4152.065785198306, 4179.519355274121, 3419.65803419661, 3466.584009918826, 3485.5643044619424, 3501.2647344057523, 3563.6614521620922, 1036.6009086501601, 1038.1487180511908, 1041.422010784007, 1047.4710271312938, 1072.126217133034, 871.9128087191231, 889.8665200220019, 891.5631340643038, 897.8114595934927, 902.0618556700957, 5179.818706345335, 5225.869353266199, 5325.707086110301, 5368.087425137736, 5394.73026348681, 392.73490393983946, 410.13256961526156, 411.8929078439567, 411.94232807406985, 417.6637806565683, 3638.2692019763226, 3651.2879988402005, 3702.72229582777, 3748.9250214995545, 3758.3047136279874, 9006.684766033157, 9372.062793720574, 9427.387219830825, 9537.856932146024, 9588.952055239819, 9419.717408477756, 9495.097965693249, 9515.143637072559, 9528.094830991045, 9532.618695252251, 7086.18508871476, 7184.640767961581, 7277.818054548678, 7373.0, 7380.077490313711, 4941.43173535048, 5087.414947280962, 5161.406438259648, 5204.297419848272, 5205.921911171411, 8523.95738021306, 8529.87205191935, 8650.524221167896, 8822.07368226327, 8868.733937981871, 8801.735947921317, 8809.471431714117, 8903.243224326005, 8944.86582701273, 9033.954830225806, 5574.191742197439, 5733.082706766897, 5737.713114344349, 6289.433950944437, 6360.554761166674, 6903.861922761416, 6965.860682786417, 7061.046758687511, 7314.305141011595, 7343.41252699772, 6524.282328943717, 6774.356436138559, 6847.452203823583, 6864.931350686629, 6939.30606939302, 6588.04473351371, 6602.1747281589805, 6635.800925972036, 6673.332666733288, 6713.295104014203, 6326.620402775849, 6366.713497892699, 6392.296847346695, 6402.551821372459, 6404.135441715309, 4502.729836209838, 4614.861554153381, 4653.255479123324, 4689.765511724332, 4706.0, 4776.694762912922, 4822.9758851205515, 4847.054824309226, 4877.658803719463, 4967.3542439482635], "value": 3999.5435697236317, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.8189404463277, 297.05240283495647, 303.3235883978727, 308.90423968569746, 309.5588785979978, 4781.306710526971, 4807.966287248241, 4830.710157390555, 4856.538628830264, 4860.829870954517, 4502.504724480313, 4547.567981041796, 4664.8134074637055, 4682.531746825316, 4771.904561908768, 3730.1980074284024, 3748.5314335708035, 3754.361758501048, 3763.7177211709095, 3764.5670747864074, 3734.7945862977526, 3749.568799588055, 3751.643593858579, 3765.3787125124322, 3772.3398405279104, 3529.7705649132854, 3625.4743062255957, 3714.848396996926, 3742.7380083394173, 3744.8876533703897, 3684.5025921500524, 3686.041629176407, 3721.1813401051727, 3727.732570925885, 3741.102135487477, 3302.735781137503, 3307.570015897942, 3317.319949410389, 3328.7503437242303, 3345.0466617014035, 4370.147821174872, 4485.0, 4520.299353600197, 4547.567981041796, 4572.314152877062, 4214.840918747338, 4233.386159006957, 4266.616004559573, 4267.957320426787, 4290.120525292307, 4885.487023862479, 4905.484924082992, 4918.23767316063, 4928.457869634337, 4972.8508144755715, 3625.6193099724414, 3626.34725749365, 3638.2905333459985, 3648.6168952259895, 3656.360136976045, 4961.5038496150455, 5145.794168233266, 5164.354455693038, 5166.638335316529, 5180.352455943007, 3676.7793932364143, 3678.9448158277114, 3685.1339935115225, 3699.4265888786745, 3740.36413809653, 3753.348526648321, 3770.6229377062073, 3774.1319496515957, 3794.4687743715904, 3794.79128647927, 4019.336809426412, 4183.267928112568, 4224.345226489838, 4224.91550169001, 4289.699721019561, 4979.45226025137, 5003.549680528697, 5018.723970181602, 5027.949720502748, 5038.924416133761, 1170.7190274334098, 1205.6383085074442, 1249.5564074753513, 1254.2787896959285, 1257.2205232755566, 842.1704620948361, 855.2473823035689, 859.9699010534727, 860.2300940658076, 861.5390765940192, 4227.260229459832, 4234.661227101825, 4262.360645903139, 4327.6970612057485, 4328.307470804656, 4941.678790878582, 4951.430585482643, 4971.701697898137, 5002.974985125051, 5018.096742586369, 4176.14389050244, 4205.9789701051295, 4225.9788701056295, 4243.872683819491, 4299.280287884871, 2587.780038696694, 2588.9870550647124, 2613.8954441822493, 2615.751503607154, 2632.2234940692542, 4607.262837945979, 4645.46577143626, 4646.97676511622, 4653.581177694024, 4653.8371157010015, 4912.287718280901, 5024.773885175176, 5047.823326183566, 5064.645474816801, 5071.746412679351, 4584.426946631671, 4587.889570797471, 4613.515580864028, 4648.721076735406, 4652.348671186037, 4860.586850117779, 4867.5132486751045, 4914.557689807934, 4931.126172054596, 4931.3096166536, 4690.607790027043, 4759.452662943806, 4776.617870570415, 4806.711597304173, 4818.0, 4554.499005109369, 4568.291914753218, 4617.6536759742485, 4619.815207391666, 4633.235516139799, 3424.5719285089363, 3502.7022703070525, 3504.28162226748, 3518.0852978225334, 3521.559805024372, 4820.590249828804, 4907.950920490892, 4918.311436398835, 4929.162042452864, 5141.922871156861, 4978.556218696683, 5000.77496512665, 5019.874503137305, 5050.0, 5067.797288108434, 4951.232558953368, 5025.246213067923, 5030.0, 5041.168207245763, 5048.444671086251, 4811.663183577256, 4907.288443175791, 4923.4584195737725, 4962.2880106363245, 4967.900641987212, 5011.649184557046, 5029.692280007152, 5030.144875371268, 5036.420811606712, 5044.772985215601, 4888.413390393175, 4901.166801643801, 4914.238293064581, 4915.926261106158, 4923.803047878045], "value": 3717.2145424636938, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.0512449189526, 761.4859969520572, 768.5772824946279, 772.6870617399953, 827.2430725885819, 12057.939710301447, 12533.498660053587, 12542.310172940495, 12726.427310771014, 12783.041271904609, 12745.936270318658, 12757.553485628005, 12829.230246185236, 12866.163699359535, 13555.322233888292, 873.7509809704236, 881.7178502879082, 882.025361975018, 882.5587206396801, 882.7219425880859, 672.146374104889, 847.4237518487427, 856.6744637037948, 878.7627340618029, 882.8719835623831, 909.7952960583882, 911.4941207629763, 911.726482055384, 913.5477938420491, 913.5797533134765, 899.491787140267, 901.8286525560155, 901.8647202919549, 902.1069141549884, 902.5442151713409, 528.577138289367, 543.1011675676762, 543.2720154992289, 654.6890227142117, 674.1943377663645, 12648.810267845989, 12721.04592155592, 12724.936375318157, 12734.745305093846, 12751.744965100646, 11384.772304553946, 11750.588729394516, 11850.111241656825, 11915.94042029793, 12118.81821772674, 11160.274582152135, 11201.159913006557, 11272.267302625385, 11322.0, 11395.487203075882, 3388.542546756206, 4086.101057767316, 4118.75287482752, 4226.746395216297, 4237.851675191384, 42407.36388954168, 44825.0, 44886.32670509945, 44957.775211123735, 45274.0, 9230.769230769285, 9440.197583205367, 9515.23878089751, 9635.614575417045, 9771.4625695586, 16871.156442177842, 17038.31846726142, 17128.914355428144, 17212.82787172112, 17219.13904304805, 6973.58370780379, 7063.187733410621, 7071.858562828715, 7110.7511237106455, 7276.381507571809, 3835.5780864104927, 3844.2888065707934, 3908.687305015592, 3914.5498267699577, 3916.2167566486814, 2836.305105249186, 2919.868605912739, 2927.9707202928125, 2928.44359571685, 2938.059820857305, 532.6165161084014, 537.1084000559131, 542.8344354971692, 543.4049715561533, 558.5252535344924, 552.6849695673427, 572.2760707704757, 585.6251998720822, 594.5006194796392, 624.6751689121631, 7711.575863327571, 7764.572948487775, 8022.59887005659, 8030.7262569832865, 8075.596220188967, 518.5151882989417, 524.520064141314, 581.7149596697587, 595.0806004722714, 646.6637348578806, 3675.889723308305, 3839.0, 3842.423636454554, 3946.131850992834, 3951.644352008333, 50714.0, 51693.22460163101, 52211.73894130505, 52646.0, 52928.73535632374, 46833.29750053752, 48264.27603585949, 48788.512114878395, 48896.0, 49257.26114108291, 40449.39325910114, 42653.0, 43606.0, 44047.0, 44702.77648611801, 8173.713920012771, 8272.296854767412, 8372.98659628924, 8522.872156917776, 8573.099824518586, 28632.42735145244, 28884.566731499464, 29520.704792951794, 30507.0, 30728.539071913492, 36559.45160822537, 38715.80642096772, 38806.0, 39106.80446597749, 39284.410733839584, 10054.748631284276, 10180.796384072426, 10296.485175741333, 10434.843477347695, 11210.87891210905, 11582.536698531965, 11873.287602743863, 12359.75280494403, 12655.367231638565, 13037.413316400594, 10200.948995254976, 11024.724381890517, 11108.111351092055, 11261.943690281496, 11613.6515904523, 11441.256318339281, 11789.469473873867, 11937.28376297425, 12067.09496787762, 12354.382280886099, 10170.644027459004, 10477.16182705397, 10508.106810921157, 10590.152787777113, 10590.364578125336, 9611.519424028911, 9676.612935482503, 9772.12050915421, 9864.79145589636, 10091.142252908585, 9870.901290986998, 9957.601695932082, 9987.750306242402, 10056.748581285234, 10201.234907381828], "value": 6090.855575745226, "unit": "score"}], "name": "dromaeo_css", "value": 6219.570590093418, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 112.0, 112.0, 114.0, 112.0, 112.0, 113.0, 112.0, 114.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 129.0, 159.0, 203.0, 132.0, 153.0, 157.0, 131.0, 202.0, 131.0], "value": 155.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 163.0, 161.0, 161.0, 162.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 126.0, 76.0, 75.0, 77.0, 76.0, 142.0, 75.0], "value": 87.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 118.0, 92.0, 93.0, 95.0, 126.0, 93.0, 93.0, 130.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 145.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 98.0, 95.0, 95.0, 96.0, 94.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 67.0, 86.0, 64.0, 64.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 63.0, 65.0, 65.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 82.0, 84.0, 84.0, 83.0, 83.0, 83.0, 84.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 133.0, 131.0, 136.0, 131.0, 128.0, 130.0, 131.0, 169.0, 133.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 172.0, 185.0, 170.0, 173.0, 179.0, 177.0, 172.0, 174.0, 170.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 69.0, 67.0, 68.0, 70.0, 66.0, 70.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1571.8000000000002, "alertThreshold": 2.0}]} 07:48:38 INFO - Return code: 0 07:48:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:48:38 ERROR - # TBPL SUCCESS # 07:48:38 INFO - Running post-action listener: _resource_record_post_action 07:48:38 INFO - ##### 07:48:38 INFO - ##### Finished run-tests step (success) 07:48:38 INFO - ##### 07:48:38 INFO - Running post-run listener: _resource_record_post_run 07:48:39 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 526303232; Read time: 984; Write time: 505604 07:48:39 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 242421760; Read time: 752; Write time: 266060 07:48:40 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283881472; Read time: 232; Write time: 239544 07:48:40 INFO - Running post-run listener: _upload_blobber_files 07:48:40 INFO - Blob upload gear active. 07:48:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:48:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:48:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:48:40 INFO - (blobuploader) - INFO - Open directory for files ... 07:48:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:48:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:48:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:41 INFO - (blobuploader) - INFO - Done attempting. 07:48:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:48:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:48:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:42 INFO - (blobuploader) - INFO - Done attempting. 07:48:42 INFO - (blobuploader) - INFO - Iteration through files over. 07:48:42 INFO - Return code: 0 07:48:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:48:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:48:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8225fd40d95dde14c8e12273a61168ca97bf1eefa984e98855f143cd97c860ca6639080cfe8f0f490fdd6cf859f6537fbb835b34861bb68397b463c43e3401c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1aabb926a5c2bd885c9a0c6b1e31388bbfb687424d38adf9239dc92b41ff0438c248c59e3491c25413a943e5caf492ec3efce864a7df063548379e0c562cc487"} 07:48:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:48:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:48:42 INFO - Contents: 07:48:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8225fd40d95dde14c8e12273a61168ca97bf1eefa984e98855f143cd97c860ca6639080cfe8f0f490fdd6cf859f6537fbb835b34861bb68397b463c43e3401c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1aabb926a5c2bd885c9a0c6b1e31388bbfb687424d38adf9239dc92b41ff0438c248c59e3491c25413a943e5caf492ec3efce864a7df063548379e0c562cc487"} 07:48:42 INFO - Running post-run listener: copy_logs_to_upload_dir 07:48:42 INFO - Copying logs to upload dir... 07:48:42 INFO - mkdir: /builds/slave/test/build/upload/logs 07:48:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.809060 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-06 07:48:41.948827) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 07:48:41.951949) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8225fd40d95dde14c8e12273a61168ca97bf1eefa984e98855f143cd97c860ca6639080cfe8f0f490fdd6cf859f6537fbb835b34861bb68397b463c43e3401c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1aabb926a5c2bd885c9a0c6b1e31388bbfb687424d38adf9239dc92b41ff0438c248c59e3491c25413a943e5caf492ec3efce864a7df063548379e0c562cc487"} build_url:https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8225fd40d95dde14c8e12273a61168ca97bf1eefa984e98855f143cd97c860ca6639080cfe8f0f490fdd6cf859f6537fbb835b34861bb68397b463c43e3401c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1aabb926a5c2bd885c9a0c6b1e31388bbfb687424d38adf9239dc92b41ff0438c248c59e3491c25413a943e5caf492ec3efce864a7df063548379e0c562cc487"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 07:48:41.976584) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:48:41.976942) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1462544435.848511-1751767730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:48:42.058523) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 07:48:42.058891) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 07:48:42.059217) ========= ========= Total master_lag: 0.17 =========