builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1461831882.48 results: success (0) buildid: 20160428004649 builduid: 97b87ca006c84df7988e97f5dc309a7a revision: 84bc3fe034f2e40438beb879b5ce59abc62f8695 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 01:24:42.478121) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 01:24:42.478645) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 01:24:42.478978) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 01:24:42.496699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:24:42.497152) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 01:24:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.0M=0s 2016-04-28 01:24:42 (67.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169494 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:24:42.681216) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:24:42.682132) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016783 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:24:42.732372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:24:42.732798) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 84bc3fe034f2e40438beb879b5ce59abc62f8695 --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 84bc3fe034f2e40438beb879b5ce59abc62f8695 --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=5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 01:24:42,862 truncating revision to first 12 chars 2016-04-28 01:24:42,862 Setting DEBUG logging. 2016-04-28 01:24:42,862 attempt 1/10 2016-04-28 01:24:42,862 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/84bc3fe034f2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 01:24:43,163 unpacking tar archive at: fx-team-84bc3fe034f2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613123 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:24:43.498026) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 01:24:43.498655) ========= script_repo_revision: 84bc3fe034f2e40438beb879b5ce59abc62f8695 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 01:24:43.499385) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 01:24:43.499919) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 01:24:43.512312) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-28 01:24:43.512885) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:24:43 INFO - MultiFileLogger online at 20160428 01:24:43 in /builds/slave/test 01:24:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:24:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:24:43 INFO - {'append_to_log': False, 01:24:43 INFO - 'base_work_dir': '/builds/slave/test', 01:24:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:24:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:24:43 INFO - 'branch': 'Fx-Team-Non-PGO', 01:24:43 INFO - 'buildbot_json_path': 'buildprops.json', 01:24:43 INFO - 'config_files': ('talos/linux_config.py',), 01:24:43 INFO - 'default_actions': ('clobber', 01:24:43 INFO - 'read-buildbot-config', 01:24:43 INFO - 'download-and-extract', 01:24:43 INFO - 'populate-webroot', 01:24:43 INFO - 'create-virtualenv', 01:24:43 INFO - 'install', 01:24:43 INFO - 'run-tests'), 01:24:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:24:43 INFO - 'download_minidump_stackwalk': True, 01:24:43 INFO - 'download_symbols': 'ondemand', 01:24:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:24:43 INFO - 'tooltool.py': '/tools/tooltool.py', 01:24:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:24:43 INFO - '/tools/misc-python/virtualenv.py')}, 01:24:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:24:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:24:43 INFO - 'installer_path': 'installer.exe', 01:24:43 INFO - 'log_level': 'info', 01:24:43 INFO - 'log_name': 'talos', 01:24:43 INFO - 'log_to_console': True, 01:24:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:24:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:24:43 INFO - 'opt_config_files': (), 01:24:43 INFO - 'pip_index': False, 01:24:43 INFO - 'sps_profile': False, 01:24:43 INFO - 'sps_profile_interval': 0, 01:24:43 INFO - 'suite': 'dromaeojs-e10s', 01:24:43 INFO - 'system_bits': '32', 01:24:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:24:43 INFO - 'title': 'talos-linux64-ix-051', 01:24:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:24:43 INFO - 'use_talos_json': True, 01:24:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:24:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:24:43 INFO - 'work_dir': 'build'} 01:24:43 INFO - ##### 01:24:43 INFO - ##### Running clobber step. 01:24:43 INFO - ##### 01:24:43 INFO - Running pre-action listener: _resource_record_pre_action 01:24:43 INFO - Running main action method: clobber 01:24:43 INFO - rmtree: /builds/slave/test/build 01:24:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:24:44 INFO - Running post-action listener: _resource_record_post_action 01:24:44 INFO - ##### 01:24:44 INFO - ##### Running read-buildbot-config step. 01:24:44 INFO - ##### 01:24:44 INFO - Running pre-action listener: _resource_record_pre_action 01:24:44 INFO - Running main action method: read_buildbot_config 01:24:44 INFO - Using buildbot properties: 01:24:44 INFO - { 01:24:44 INFO - "project": "", 01:24:44 INFO - "product": "firefox", 01:24:44 INFO - "script_repo_revision": "production", 01:24:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:24:44 INFO - "repository": "", 01:24:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 01:24:44 INFO - "buildid": "20160428004649", 01:24:44 INFO - "pgo_build": "False", 01:24:44 INFO - "basedir": "/builds/slave/test", 01:24:44 INFO - "buildnumber": 1228, 01:24:44 INFO - "slavename": "talos-linux64-ix-051", 01:24:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:24:44 INFO - "platform": "ubuntu64_hw", 01:24:44 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:24:44 INFO - "branch": "fx-team", 01:24:44 INFO - "repo_path": "integration/fx-team", 01:24:44 INFO - "revision": "84bc3fe034f2e40438beb879b5ce59abc62f8695", 01:24:44 INFO - "stage_platform": "linux64", 01:24:44 INFO - "builduid": "97b87ca006c84df7988e97f5dc309a7a", 01:24:44 INFO - "slavebuilddir": "test" 01:24:44 INFO - } 01:24:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:24:44 INFO - Running post-action listener: _resource_record_post_action 01:24:44 INFO - ##### 01:24:44 INFO - ##### Running download-and-extract step. 01:24:44 INFO - ##### 01:24:44 INFO - Running pre-action listener: _resource_record_pre_action 01:24:44 INFO - Running main action method: download_and_extract 01:24:44 INFO - mkdir: /builds/slave/test/build/tests 01:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:44 INFO - https://queue.taskcluster.net/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:24:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:24:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:24:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/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 01:24:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/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 01:24:45 INFO - Downloaded 1361 bytes. 01:24:45 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:24:45 INFO - Using the following test package requirements: 01:24:45 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:24:45 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:24:45 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:24:45 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:45 INFO - u'jsshell-linux-x86_64.zip'], 01:24:45 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:24:45 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:24:45 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:24:45 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:24:45 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:24:45 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:24:45 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:24:45 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')]} 01:24:45 INFO - https://queue.taskcluster.net/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:24:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:24:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:24:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/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 01:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/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 01:24:58 INFO - Downloaded 22293278 bytes. 01:24:58 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'] 01:24:58 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 01:24:59 INFO - Return code: 0 01:24:59 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 01:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:59 INFO - https://queue.taskcluster.net/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:24:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:24:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:24:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/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 01:24:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/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 01:25:01 INFO - Downloaded 22293278 bytes. 01:25:01 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'] 01:25:01 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 01:25:03 INFO - Return code: 0 01:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:03 INFO - https://queue.taskcluster.net/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:25:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:25:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:25:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/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 01:25:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/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 01:25:05 INFO - Downloaded 10840145 bytes. 01:25:05 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'] 01:25:05 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 01:25:06 INFO - Return code: 0 01:25:06 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')]} 01:25:06 INFO - https://queue.taskcluster.net/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:25:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:25:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:25:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/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 01:25:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABPnl1ZkTVKuh1e-hvUvow/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 01:25:07 INFO - Downloaded 54839859 bytes. 01:25:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:25:07 INFO - mkdir: /builds/slave/test/properties 01:25:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:25:07 INFO - Writing to file /builds/slave/test/properties/build_url 01:25:07 INFO - Contents: 01:25:07 INFO - build_url:https://queue.taskcluster.net/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:25:08 INFO - Running post-action listener: _resource_record_post_action 01:25:08 INFO - Running post-action listener: set_extra_try_arguments 01:25:08 INFO - ##### 01:25:08 INFO - ##### Running populate-webroot step. 01:25:08 INFO - ##### 01:25:08 INFO - Running pre-action listener: _resource_record_pre_action 01:25:08 INFO - Running main action method: populate_webroot 01:25:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:25:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:25:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:25:08 INFO - '--tppagecycles', 01:25:08 INFO - '7'], 01:25:08 INFO - 'tests': ['tsvgm']}}, 01:25:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:25:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:25:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:25:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:25:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:25:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:25:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:08 INFO - 'talos_options': ['--disable-e10s'], 01:25:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:08 INFO - 'talos_options': ['--disable-e10s'], 01:25:08 INFO - 'tests': ['damp', 'tps']}, 01:25:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:08 INFO - 'tests': ['damp', 'tps']}, 01:25:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:25:08 INFO - 'tests': ['dromaeo_dom']}, 01:25:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:25:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:25:08 INFO - 'tests': ['a11yr', 01:25:08 INFO - 'ts_paint', 01:25:08 INFO - 'tpaint', 01:25:08 INFO - 'sessionrestore', 01:25:08 INFO - 'sessionrestore_no_auto_restore', 01:25:08 INFO - 'tabpaint']}, 01:25:08 INFO - 'other-e10s': {'tests': ['a11yr', 01:25:08 INFO - 'ts_paint', 01:25:08 INFO - 'tpaint', 01:25:08 INFO - 'sessionrestore', 01:25:08 INFO - 'sessionrestore_no_auto_restore', 01:25:08 INFO - 'tabpaint']}, 01:25:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:25:08 INFO - 'ts_paint', 01:25:08 INFO - 'tpaint', 01:25:08 INFO - 'sessionrestore', 01:25:08 INFO - 'sessionrestore_no_auto_restore', 01:25:08 INFO - 'tabpaint']}, 01:25:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:25:08 INFO - 'ts_paint', 01:25:08 INFO - 'tpaint', 01:25:08 INFO - 'sessionrestore', 01:25:08 INFO - 'sessionrestore_no_auto_restore', 01:25:08 INFO - 'tabpaint']}, 01:25:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:25:08 INFO - 'tests': ['a11yr', 01:25:08 INFO - 'ts_paint', 01:25:08 INFO - 'tpaint', 01:25:08 INFO - 'sessionrestore', 01:25:08 INFO - 'sessionrestore_no_auto_restore', 01:25:08 INFO - 'tabpaint']}, 01:25:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:25:08 INFO - 'tests': ['a11yr', 01:25:08 INFO - 'ts_paint', 01:25:08 INFO - 'tpaint', 01:25:08 INFO - 'sessionrestore', 01:25:08 INFO - 'sessionrestore_no_auto_restore', 01:25:08 INFO - 'tabpaint']}, 01:25:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:25:08 INFO - 'tests': ['tsvgx', 01:25:08 INFO - 'tsvgr_opacity', 01:25:08 INFO - 'tart', 01:25:08 INFO - 'tscrollx', 01:25:08 INFO - 'cart']}, 01:25:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:25:08 INFO - 'tsvgr_opacity', 01:25:08 INFO - 'tart', 01:25:08 INFO - 'tscrollx', 01:25:08 INFO - 'cart']}, 01:25:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:08 INFO - 'talos_options': ['--disable-e10s'], 01:25:08 INFO - 'tests': ['tp5o']}, 01:25:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:08 INFO - 'tests': ['tp5o']}, 01:25:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:08 INFO - 'talos_options': ['--disable-e10s', 01:25:08 INFO - '--xperf_path', 01:25:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:08 INFO - 'tests': ['tp5n']}, 01:25:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:08 INFO - 'talos_options': ['--xperf_path', 01:25:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:08 INFO - 'tests': ['tp5n']}}, 01:25:08 INFO - 'talos.zip': {'path': '', 01:25:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:25:08 INFO - Running post-action listener: _resource_record_post_action 01:25:08 INFO - ##### 01:25:08 INFO - ##### Running create-virtualenv step. 01:25:08 INFO - ##### 01:25:08 INFO - Running pre-action listener: _resource_record_pre_action 01:25:08 INFO - Running main action method: create_virtualenv 01:25:08 INFO - Creating virtualenv /builds/slave/test/build/venv 01:25:08 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 01:25:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:25:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:25:08 INFO - Using real prefix '/usr' 01:25:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:25:08 INFO - Installing distribute.............................................................................................................................................................................................done. 01:25:10 INFO - Installing pip.................done. 01:25:10 INFO - Return code: 0 01:25:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:25: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')]} 01:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25: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')]} 01:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:10 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 0x7f3bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421410>, '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 0x2422310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24227a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', '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 01:25:10 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 01:25:10 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 01:25:10 INFO - Using env: {'DISPLAY': ':0', 01:25:10 INFO - 'HOME': '/home/cltbld', 01:25:10 INFO - 'LANG': 'en_US.UTF-8', 01:25:10 INFO - 'LANGUAGE': 'en_US:en', 01:25:10 INFO - 'LOGNAME': 'cltbld', 01:25:10 INFO - 'MAIL': '/var/mail/cltbld', 01:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:10 INFO - 'MOZ_NO_REMOTE': '1', 01:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:10 INFO - 'NO_EM_RESTART': '1', 01:25:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:10 INFO - 'PWD': '/builds/slave/test', 01:25:10 INFO - 'SHELL': '/bin/bash', 01:25:10 INFO - 'SHLVL': '1', 01:25:10 INFO - 'TERM': 'linux', 01:25:10 INFO - 'TMOUT': '86400', 01:25:10 INFO - 'USER': 'cltbld', 01:25:10 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', 01:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:10 INFO - '_': '/tools/buildbot/bin/python'} 01:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:11 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 01:25:11 INFO - Cleaning up... 01:25:11 INFO - Return code: 0 01:25:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421410>, '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 0x2422310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24227a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', '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 01:25:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:25:11 INFO - Using env: {'DISPLAY': ':0', 01:25:11 INFO - 'HOME': '/home/cltbld', 01:25:11 INFO - 'LANG': 'en_US.UTF-8', 01:25:11 INFO - 'LANGUAGE': 'en_US:en', 01:25:11 INFO - 'LOGNAME': 'cltbld', 01:25:11 INFO - 'MAIL': '/var/mail/cltbld', 01:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:11 INFO - 'MOZ_NO_REMOTE': '1', 01:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:11 INFO - 'NO_EM_RESTART': '1', 01:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:11 INFO - 'PWD': '/builds/slave/test', 01:25:11 INFO - 'SHELL': '/bin/bash', 01:25:11 INFO - 'SHLVL': '1', 01:25:11 INFO - 'TERM': 'linux', 01:25:11 INFO - 'TMOUT': '86400', 01:25:11 INFO - 'USER': 'cltbld', 01:25:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', 01:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:11 INFO - '_': '/tools/buildbot/bin/python'} 01:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:11 INFO - Downloading/unpacking psutil>=0.7.1 01:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:25:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:25:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:25:13 INFO - Installing collected packages: psutil 01:25:13 INFO - Running setup.py install for psutil 01:25:13 INFO - building 'psutil._psutil_linux' extension 01:25:13 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 01:25:13 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 01:25:13 INFO - building 'psutil._psutil_posix' extension 01:25:13 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 01:25:13 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 01:25:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:25:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:25:13 INFO - Successfully installed psutil 01:25:13 INFO - Cleaning up... 01:25:13 INFO - Return code: 0 01:25:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421410>, '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 0x2422310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24227a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', '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 01:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:25:13 INFO - Using env: {'DISPLAY': ':0', 01:25:13 INFO - 'HOME': '/home/cltbld', 01:25:13 INFO - 'LANG': 'en_US.UTF-8', 01:25:13 INFO - 'LANGUAGE': 'en_US:en', 01:25:13 INFO - 'LOGNAME': 'cltbld', 01:25:13 INFO - 'MAIL': '/var/mail/cltbld', 01:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:13 INFO - 'MOZ_NO_REMOTE': '1', 01:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:13 INFO - 'NO_EM_RESTART': '1', 01:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:13 INFO - 'PWD': '/builds/slave/test', 01:25:13 INFO - 'SHELL': '/bin/bash', 01:25:13 INFO - 'SHLVL': '1', 01:25:13 INFO - 'TERM': 'linux', 01:25:13 INFO - 'TMOUT': '86400', 01:25:13 INFO - 'USER': 'cltbld', 01:25:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', 01:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:13 INFO - '_': '/tools/buildbot/bin/python'} 01:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:25:15 INFO - Installing collected packages: mozsystemmonitor 01:25:15 INFO - Running setup.py install for mozsystemmonitor 01:25:15 INFO - Successfully installed mozsystemmonitor 01:25:15 INFO - Cleaning up... 01:25:16 INFO - Return code: 0 01:25:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:25: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')]} 01:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25: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')]} 01:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25: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', '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 0x7f3bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421410>, '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 0x2422310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24227a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', '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 01:25: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:25: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 blobuploader==1.2.4 01:25:16 INFO - Using env: {'DISPLAY': ':0', 01:25:16 INFO - 'HOME': '/home/cltbld', 01:25:16 INFO - 'LANG': 'en_US.UTF-8', 01:25:16 INFO - 'LANGUAGE': 'en_US:en', 01:25:16 INFO - 'LOGNAME': 'cltbld', 01:25:16 INFO - 'MAIL': '/var/mail/cltbld', 01:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:16 INFO - 'MOZ_NO_REMOTE': '1', 01:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:16 INFO - 'NO_EM_RESTART': '1', 01:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:16 INFO - 'PWD': '/builds/slave/test', 01:25:16 INFO - 'SHELL': '/bin/bash', 01:25:16 INFO - 'SHLVL': '1', 01:25:16 INFO - 'TERM': 'linux', 01:25:16 INFO - 'TMOUT': '86400', 01:25:16 INFO - 'USER': 'cltbld', 01:25:16 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', 01:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:16 INFO - '_': '/tools/buildbot/bin/python'} 01:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:16 INFO - Downloading/unpacking blobuploader==1.2.4 01:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:18 INFO - Downloading blobuploader-1.2.4.tar.gz 01:25:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:25:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:25:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:18 INFO - Downloading docopt-0.6.1.tar.gz 01:25:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:25:18 INFO - Installing collected packages: blobuploader, requests, docopt 01:25:18 INFO - Running setup.py install for blobuploader 01:25:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:25:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:25:18 INFO - Running setup.py install for requests 01:25:19 INFO - Running setup.py install for docopt 01:25:19 INFO - Successfully installed blobuploader requests docopt 01:25:19 INFO - Cleaning up... 01:25:19 INFO - Return code: 0 01:25:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25: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')]} 01:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25: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')]} 01:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:19 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 0x7f3bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421410>, '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 0x2422310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24227a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', '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 01:25:19 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 01:25:19 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 01:25:19 INFO - Using env: {'DISPLAY': ':0', 01:25:19 INFO - 'HOME': '/home/cltbld', 01:25:19 INFO - 'LANG': 'en_US.UTF-8', 01:25:19 INFO - 'LANGUAGE': 'en_US:en', 01:25:19 INFO - 'LOGNAME': 'cltbld', 01:25:19 INFO - 'MAIL': '/var/mail/cltbld', 01:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:19 INFO - 'MOZ_NO_REMOTE': '1', 01:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:19 INFO - 'NO_EM_RESTART': '1', 01:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:19 INFO - 'PWD': '/builds/slave/test', 01:25:19 INFO - 'SHELL': '/bin/bash', 01:25:19 INFO - 'SHLVL': '1', 01:25:19 INFO - 'TERM': 'linux', 01:25:19 INFO - 'TMOUT': '86400', 01:25:19 INFO - 'USER': 'cltbld', 01:25:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', 01:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:19 INFO - '_': '/tools/buildbot/bin/python'} 01:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:25:19 INFO - Running setup.py (path:/tmp/pip-UvLPDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:25:19 INFO - Running setup.py (path:/tmp/pip-S24Jg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:25:19 INFO - Running setup.py (path:/tmp/pip-cEuU_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:25:19 INFO - Running setup.py (path:/tmp/pip-1CZKDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:25:19 INFO - Running setup.py (path:/tmp/pip-dE7sqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:25:20 INFO - Running setup.py (path:/tmp/pip-8brKat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:25:20 INFO - Running setup.py (path:/tmp/pip-tjwAHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:25:20 INFO - Running setup.py (path:/tmp/pip-I3ybBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:25:20 INFO - Running setup.py (path:/tmp/pip-OuaEdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:25:20 INFO - Running setup.py (path:/tmp/pip-LAbn6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:25:20 INFO - Running setup.py (path:/tmp/pip-Z6FcMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:25:20 INFO - Running setup.py (path:/tmp/pip-eUZxJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:25:20 INFO - Running setup.py (path:/tmp/pip-88lQlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:25:20 INFO - Running setup.py (path:/tmp/pip-Ff4g0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:20 INFO - Running setup.py (path:/tmp/pip-3rw4hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:25:20 INFO - Running setup.py (path:/tmp/pip-sL8ylk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:25:20 INFO - Running setup.py (path:/tmp/pip-xk0Mlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:25:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:25:20 INFO - Running setup.py install for manifestparser 01:25:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:25:21 INFO - Running setup.py install for mozcrash 01:25:21 INFO - Running setup.py install for mozdebug 01:25:21 INFO - Running setup.py install for mozdevice 01:25:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:25:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:25:21 INFO - Running setup.py install for mozfile 01:25:21 INFO - Running setup.py install for mozhttpd 01:25:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:25:21 INFO - Running setup.py install for mozinfo 01:25:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:25:21 INFO - Running setup.py install for mozInstall 01:25:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:25:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:25:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:25:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:25:21 INFO - Running setup.py install for mozleak 01:25:21 INFO - Running setup.py install for mozlog 01:25:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:25:21 INFO - Running setup.py install for moznetwork 01:25:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:25:22 INFO - Running setup.py install for mozprocess 01:25:22 INFO - Running setup.py install for mozprofile 01:25:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:25:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:25:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:25:22 INFO - Running setup.py install for mozrunner 01:25:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:25:22 INFO - Running setup.py install for mozscreenshot 01:25:22 INFO - Running setup.py install for moztest 01:25:22 INFO - Running setup.py install for mozversion 01:25:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:25:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:25:22 INFO - Cleaning up... 01:25:22 INFO - Return code: 0 01:25:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25: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')]} 01:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25: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')]} 01:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:22 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 0x7f3bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421410>, '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 0x2422310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24227a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', '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 01:25:22 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 01:25:22 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 01:25:22 INFO - Using env: {'DISPLAY': ':0', 01:25:22 INFO - 'HOME': '/home/cltbld', 01:25:22 INFO - 'LANG': 'en_US.UTF-8', 01:25:22 INFO - 'LANGUAGE': 'en_US:en', 01:25:22 INFO - 'LOGNAME': 'cltbld', 01:25:22 INFO - 'MAIL': '/var/mail/cltbld', 01:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:22 INFO - 'MOZ_NO_REMOTE': '1', 01:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:22 INFO - 'NO_EM_RESTART': '1', 01:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:22 INFO - 'PWD': '/builds/slave/test', 01:25:22 INFO - 'SHELL': '/bin/bash', 01:25:22 INFO - 'SHLVL': '1', 01:25:22 INFO - 'TERM': 'linux', 01:25:22 INFO - 'TMOUT': '86400', 01:25:22 INFO - 'USER': 'cltbld', 01:25:22 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', 01:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:22 INFO - '_': '/tools/buildbot/bin/python'} 01:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:25:23 INFO - Running setup.py (path:/tmp/pip-SePtLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:25:23 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)) 01:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:25:23 INFO - Running setup.py (path:/tmp/pip-7DD7RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:25:23 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)) 01:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:25:23 INFO - Running setup.py (path:/tmp/pip-GWrCJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:25:23 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)) 01:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:25:23 INFO - Running setup.py (path:/tmp/pip-NM5bp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:25:23 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)) 01:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:25:23 INFO - Running setup.py (path:/tmp/pip-3yHXjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:25:23 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)) 01:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:25:23 INFO - Running setup.py (path:/tmp/pip-1BRcBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:25:23 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)) 01:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:25:23 INFO - Running setup.py (path:/tmp/pip-h3oW8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:25:23 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)) 01:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:25:23 INFO - Running setup.py (path:/tmp/pip-qKoNWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:25:23 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)) 01:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:25:23 INFO - Running setup.py (path:/tmp/pip-ecSMi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:25:23 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)) 01:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:25:23 INFO - Running setup.py (path:/tmp/pip-BLcYRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:25:23 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)) 01:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:25:23 INFO - Running setup.py (path:/tmp/pip-mIkT1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:25:23 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)) 01:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:25:23 INFO - Running setup.py (path:/tmp/pip-DngDry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:25:23 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)) 01:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:25:23 INFO - Running setup.py (path:/tmp/pip-cldgey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:25:23 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)) 01:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:25:23 INFO - Running setup.py (path:/tmp/pip-FROj48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:25:24 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)) 01:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:24 INFO - Running setup.py (path:/tmp/pip-6RxVyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:24 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)) 01:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:25:24 INFO - Running setup.py (path:/tmp/pip-I3pKfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:25:24 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)) 01:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:25:24 INFO - Running setup.py (path:/tmp/pip-7LTb9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:25:24 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)) 01:25:24 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)) 01:25:24 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)) 01:25:24 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)) 01:25:24 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)) 01:25:24 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)) 01:25:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:26 INFO - Downloading blessings-1.6.tar.gz 01:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:25:26 INFO - Installing collected packages: blessings 01:25:26 INFO - Running setup.py install for blessings 01:25:26 INFO - Successfully installed blessings 01:25:26 INFO - Cleaning up... 01:25:26 INFO - Return code: 0 01:25:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:25:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:25:26 INFO - Reading from file tmpfile_stdout 01:25:26 INFO - Current package versions: 01:25:26 INFO - argparse == 1.2.1 01:25:26 INFO - blessings == 1.6 01:25:26 INFO - blobuploader == 1.2.4 01:25:26 INFO - docopt == 0.6.1 01:25:26 INFO - manifestparser == 1.1 01:25:26 INFO - mozInstall == 1.12 01:25:26 INFO - mozcrash == 0.17 01:25:26 INFO - mozdebug == 0.1 01:25:26 INFO - mozdevice == 0.48 01:25:26 INFO - mozfile == 1.2 01:25:26 INFO - mozhttpd == 0.7 01:25:26 INFO - mozinfo == 0.9 01:25:26 INFO - mozleak == 0.1 01:25:26 INFO - mozlog == 3.1 01:25:26 INFO - moznetwork == 0.27 01:25:26 INFO - mozprocess == 0.22 01:25:26 INFO - mozprofile == 0.28 01:25:26 INFO - mozrunner == 6.11 01:25:26 INFO - mozscreenshot == 0.1 01:25:26 INFO - mozsystemmonitor == 0.0 01:25:26 INFO - moztest == 0.7 01:25:26 INFO - mozversion == 1.4 01:25:26 INFO - psutil == 3.1.1 01:25:26 INFO - requests == 1.2.3 01:25:26 INFO - wsgiref == 0.1.2 01:25:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:26 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')]} 01:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:26 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')]} 01:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:26 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 0x7f3bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421410>, '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 0x2422310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24227a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', '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 01:25:26 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 01:25:26 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 01:25:26 INFO - Using env: {'DISPLAY': ':0', 01:25:26 INFO - 'HOME': '/home/cltbld', 01:25:26 INFO - 'LANG': 'en_US.UTF-8', 01:25:26 INFO - 'LANGUAGE': 'en_US:en', 01:25:26 INFO - 'LOGNAME': 'cltbld', 01:25:26 INFO - 'MAIL': '/var/mail/cltbld', 01:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:26 INFO - 'MOZ_NO_REMOTE': '1', 01:25:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:26 INFO - 'NO_EM_RESTART': '1', 01:25:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:26 INFO - 'PWD': '/builds/slave/test', 01:25:26 INFO - 'SHELL': '/bin/bash', 01:25:26 INFO - 'SHLVL': '1', 01:25:26 INFO - 'TERM': 'linux', 01:25:26 INFO - 'TMOUT': '86400', 01:25:26 INFO - 'USER': 'cltbld', 01:25:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', 01:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:26 INFO - '_': '/tools/buildbot/bin/python'} 01:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:27 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)) 01:25:27 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)) 01:25:27 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)) 01:25:27 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)) 01:25:27 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)) 01:25:27 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)) 01:25:27 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)) 01:25:27 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)) 01:25:27 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)) 01:25:27 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)) 01:25:27 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)) 01:25:27 INFO - Cleaning up... 01:25:27 INFO - Return code: 0 01:25:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:25:27 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')]} 01:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:27 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')]} 01:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:27 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 0x7f3bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421410>, '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 0x2422310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24227a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', '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 01:25:27 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 01:25:27 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 01:25:27 INFO - Using env: {'DISPLAY': ':0', 01:25:27 INFO - 'HOME': '/home/cltbld', 01:25:27 INFO - 'LANG': 'en_US.UTF-8', 01:25:27 INFO - 'LANGUAGE': 'en_US:en', 01:25:27 INFO - 'LOGNAME': 'cltbld', 01:25:27 INFO - 'MAIL': '/var/mail/cltbld', 01:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:27 INFO - 'MOZ_NO_REMOTE': '1', 01:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:27 INFO - 'NO_EM_RESTART': '1', 01:25:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:27 INFO - 'PWD': '/builds/slave/test', 01:25:27 INFO - 'SHELL': '/bin/bash', 01:25:27 INFO - 'SHLVL': '1', 01:25:27 INFO - 'TERM': 'linux', 01:25:27 INFO - 'TMOUT': '86400', 01:25:27 INFO - 'USER': 'cltbld', 01:25:27 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', 01:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:27 INFO - '_': '/tools/buildbot/bin/python'} 01:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:27 INFO - Downloading/unpacking jsonschema 01:25:27 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 01:25:27 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 01:25:27 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 01:25:27 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 01:25:27 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 01:25:27 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 01:25:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:25:29 INFO - Downloading/unpacking functools32 (from jsonschema) 01:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:29 INFO - Downloading functools32-3.2.3-2.tar.gz 01:25:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:25:29 INFO - warning: no files found matching '*.txt' 01:25:29 INFO - no previously-included directories found matching 'build' 01:25:29 INFO - no previously-included directories found matching 'dist' 01:25:29 INFO - no previously-included directories found matching '.git*' 01:25:29 INFO - Installing collected packages: jsonschema, functools32 01:25:29 INFO - Running setup.py install for functools32 01:25:29 INFO - warning: no files found matching '*.txt' 01:25:29 INFO - no previously-included directories found matching 'build' 01:25:29 INFO - no previously-included directories found matching 'dist' 01:25:29 INFO - no previously-included directories found matching '.git*' 01:25:29 INFO - Successfully installed jsonschema functools32 01:25:29 INFO - Cleaning up... 01:25:29 INFO - Return code: 0 01:25:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2421410>, '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 0x2422310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24227a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', '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 01:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:25:29 INFO - Using env: {'DISPLAY': ':0', 01:25:29 INFO - 'HOME': '/home/cltbld', 01:25:29 INFO - 'LANG': 'en_US.UTF-8', 01:25:29 INFO - 'LANGUAGE': 'en_US:en', 01:25:29 INFO - 'LOGNAME': 'cltbld', 01:25:29 INFO - 'MAIL': '/var/mail/cltbld', 01:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:29 INFO - 'MOZ_NO_REMOTE': '1', 01:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:29 INFO - 'NO_EM_RESTART': '1', 01:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:29 INFO - 'PWD': '/builds/slave/test', 01:25:29 INFO - 'SHELL': '/bin/bash', 01:25:29 INFO - 'SHLVL': '1', 01:25:29 INFO - 'TERM': 'linux', 01:25:29 INFO - 'TMOUT': '86400', 01:25:29 INFO - 'USER': 'cltbld', 01:25:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', 01:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:29 INFO - '_': '/tools/buildbot/bin/python'} 01:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:29 INFO - Downloading/unpacking flake8 01:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:25:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:25:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:25:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:25:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:25:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:25:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:25:32 INFO - no previously-included directories found matching 'docs/_build' 01:25:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:25:32 INFO - Running setup.py install for pep8 01:25:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:25:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:25:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:25:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:25:32 INFO - no previously-included directories found matching 'docs/_build' 01:25:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:25:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:25:32 INFO - Cleaning up... 01:25:33 INFO - Return code: 0 01:25:33 INFO - Running post-action listener: _resource_record_post_action 01:25:33 INFO - Running post-action listener: _start_resource_monitoring 01:25:33 INFO - Starting resource monitoring. 01:25:33 INFO - ##### 01:25:33 INFO - ##### Running install step. 01:25:33 INFO - ##### 01:25:33 INFO - Running pre-action listener: _resource_record_pre_action 01:25:33 INFO - Running main action method: install 01:25:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:25:33 INFO - Reading from file tmpfile_stdout 01:25:33 INFO - Detecting whether we're running mozinstall >=1.0... 01:25:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:25:33 INFO - Reading from file tmpfile_stdout 01:25:33 INFO - Output received: 01:25:33 INFO - Usage: mozinstall [options] installer 01:25:33 INFO - Options: 01:25:33 INFO - -h, --help show this help message and exit 01:25:33 INFO - -d DEST, --destination=DEST 01:25:33 INFO - Directory to install application into. [default: 01:25:33 INFO - "/builds/slave/test"] 01:25:33 INFO - --app=APP Application being installed. [default: firefox] 01:25:33 INFO - mkdir: /builds/slave/test/build/application 01:25:33 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'] 01:25:33 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 01:25:49 INFO - Reading from file tmpfile_stdout 01:25:49 INFO - Output received: 01:25:49 INFO - /builds/slave/test/build/application/firefox/firefox 01:25:49 INFO - Running post-action listener: _resource_record_post_action 01:25:49 INFO - ##### 01:25:49 INFO - ##### Running run-tests step. 01:25:49 INFO - ##### 01:25:49 INFO - Running pre-action listener: _resource_record_pre_action 01:25:49 INFO - Running main action method: run_tests 01:25:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:25:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:25:49 INFO - Python 2.7.3 01:25:49 INFO - Return code: 0 01:25:49 INFO - grabbing minidump binary from tooltool 01:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:49 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 0x2421410>, '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 0x2422310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24227a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:25:49 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 01:25:49 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 01:25:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:25:49 INFO - Return code: 0 01:25:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:25:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:25:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:25:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:25:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:25:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:25:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:25:50 INFO - Return code: 0 01:25:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:25:50 INFO - Using env: {'DISPLAY': ':0', 01:25:50 INFO - 'HOME': '/home/cltbld', 01:25:50 INFO - 'LANG': 'en_US.UTF-8', 01:25:50 INFO - 'LANGUAGE': 'en_US:en', 01:25:50 INFO - 'LOGNAME': 'cltbld', 01:25:50 INFO - 'MAIL': '/var/mail/cltbld', 01:25:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:25:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:50 INFO - 'MOZ_NO_REMOTE': '1', 01:25:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:50 INFO - 'NO_EM_RESTART': '1', 01:25:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:50 INFO - 'PWD': '/builds/slave/test', 01:25:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:25:50 INFO - 'SHELL': '/bin/bash', 01:25:50 INFO - 'SHLVL': '1', 01:25:50 INFO - 'TERM': 'linux', 01:25:50 INFO - 'TMOUT': '86400', 01:25:50 INFO - 'USER': 'cltbld', 01:25:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778', 01:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:50 INFO - '_': '/tools/buildbot/bin/python'} 01:25:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:25:50 INFO - mozversion application_buildid: 20160428004649 01:25:50 INFO - mozversion application_changeset: 84bc3fe034f2e40438beb879b5ce59abc62f8695 01:25:50 INFO - mozversion application_display_name: Nightly 01:25:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:25:50 INFO - mozversion application_name: Firefox 01:25:50 INFO - mozversion application_remotingname: firefox 01:25:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:25:50 INFO - mozversion application_vendor: Mozilla 01:25:50 INFO - mozversion application_version: 49.0a1 01:25:50 INFO - mozversion platform_buildid: 20160428004649 01:25:50 INFO - mozversion platform_changeset: 84bc3fe034f2e40438beb879b5ce59abc62f8695 01:25:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:25:50 INFO - mozversion platform_version: 49.0a1 01:25:50 INFO - using testdate: 1461831950 01:25:50 INFO - actual date: 1461831950 01:25:50 INFO - starting webserver on 'localhost:44299' 01:25:50 INFO - SUITE-START | Running 2 tests 01:25:50 INFO - TEST-START | dromaeo_css 01:25:50 INFO - operating with platform_type : linux_ 01:25:50 INFO - Initialising browser for dromaeo_css test... 01:25:50 INFO - TEST-INFO | started process 4660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMpKYvC/profile http://localhost:44299/getInfo.html) 01:25:54 INFO - PROCESS | 4660 | 01:25:54 INFO - PROCESS | 4660 | (process:4725): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:25:55 INFO - PROCESS | 4660 | __metrics Screen width/height:1600/1200 01:25:55 INFO - PROCESS | 4660 | colorDepth:24 01:25:55 INFO - PROCESS | 4660 | Browser inner width/height: 1024/697 01:25:55 INFO - PROCESS | 4660 | __metrics 01:25:56 ERROR - PROCESS | 4660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 01:25:57 INFO - TEST-INFO | 4660: exit 0 01:25:57 INFO - Browser initialized. 01:25:57 INFO - Running cycle 1/1 for dromaeo_css test... 01:25:57 INFO - TEST-INFO | started process 4776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMpKYvC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:25:58 INFO - PROCESS | 4776 | 01:25:58 INFO - PROCESS | 4776 | (process:4835): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:26:08 INFO - PROCESS | 4776 | RSS: Main: 166240256 01:26:08 INFO - PROCESS | 4776 | 01:26:58 INFO - PROCESS | 4776 | 1461832018502 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] 01:29:10 INFO - PROCESS | 4776 | Cycle 1(1): loaded http://localhost:44299/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44299/tests/dromaeo/cssquery-ext.html) 01:29:11 INFO - PROCESS | 4776 | RSS: Main: 169148416 01:29:11 INFO - PROCESS | 4776 | 01:32:13 INFO - PROCESS | 4776 | Cycle 1(1): loaded http://localhost:44299/tests/dromaeo/cssquery-ext.html (next: http://localhost:44299/tests/dromaeo/cssquery-jquery.html) 01:32:14 INFO - PROCESS | 4776 | RSS: Main: 166993920 01:32:14 INFO - PROCESS | 4776 | 01:35:16 INFO - PROCESS | 4776 | Cycle 1(1): loaded http://localhost:44299/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44299/tests/dromaeo/cssquery-mootools.html) 01:35:16 INFO - PROCESS | 4776 | RSS: Main: 168120320 01:35:16 INFO - PROCESS | 4776 | 01:38:18 INFO - PROCESS | 4776 | Cycle 1(1): loaded http://localhost:44299/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44299/tests/dromaeo/cssquery-prototype.html) 01:38:19 INFO - PROCESS | 4776 | RSS: Main: 166035456 01:38:19 INFO - PROCESS | 4776 | 01:41:21 INFO - PROCESS | 4776 | Cycle 1(1): loaded http://localhost:44299/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44299/tests/dromaeo/cssquery-yui.html) 01:41:22 INFO - PROCESS | 4776 | RSS: Main: 167673856 01:41:22 INFO - PROCESS | 4776 | 01:44:24 INFO - PROCESS | 4776 | Cycle 1(1): loaded http://localhost:44299/tests/dromaeo/cssquery-yui.html (next: http://localhost:44299/tests/dromaeo/cssquery-dojo.html) 01:44:25 INFO - PROCESS | 4776 | RSS: Main: 169361408 01:44:25 INFO - PROCESS | 4776 | 01:44:25 INFO - PROCESS | 4776 | __start_tp_report 01:44:25 INFO - PROCESS | 4776 | _x_x_mozilla_page_load 01:44:25 INFO - PROCESS | 4776 | _x_x_mozilla_page_load_details 01:44:25 INFO - PROCESS | 4776 | |i|pagename|runs| 01:44:25 INFO - PROCESS | 4776 | |0;dojo.html;2647.9602805957907;2722.6052222427747;2749.450109978005;2750.1612008337447;2758.103616324695;4803.111424386491;4808.158572249851;4840.443349014864;4873.585745211657;4902.779374928128;4776.808927642899;4809.495003024685;4856.951430485694;4898.338724272222;4899.289603007562;4377.343398490228;4446.3108218226225;4493.505714371417;4498.100379924012;4500;4430.55694430556;4548.454185497745;4561.863144105666;4584.381108550353;4592.448906131269;4357.869263922087;4396.802143903532;4457.175422546839;4486.057927835142;4549.840755573572;4458.264386376244;4485.3944717463055;4492.9775351123035;4496.325551167319;4535.886602834922;4426.800793964279;4434.268345722952;4437.755923424211;4458.264386376244;4478.283474644041;4707.411573553306;4747.786349614241;4811.302361157613;4815;4867.951320486785;5137.40919794221;5170.586353091781;5173.81891633791;5174.611904107207;5191.325127733408;5086.821961231376;5211.895762084737;5217.58259339252;5219.42586315505;5222.817201397933;4749.145153872267;4761.904761904742;4787.832425865147;4821.590164835993;4840.322354870321;5312.1766126250495;5428.321459817523;5446.428125046892;5446.891062178814;5482.259894914136;4924.384451943507;5036.6726162799305;5172.482751724798;5193.610479214074;5208.5051920067535;5092.955944031539;5180.145276029489;5207.270982062514;5210.895782084337;5262.2632831403635;4994.750262486934;5140.742962851842;5195.454477279907;5204.505571970657;5252;4936.703797772073;5148.382194136728;5156.020356132323;5159.96800639866;5165.715885626327;4011.9769458787823;4018.598140185958;4033.072393349546;4050.5544390117066;4062.532808726975;3564.6791788739138;3569.7679650822615;3575.3206890690685;3594.532710747586;3609.8375573099274;4520.660950428731;4551.135284295973;4559.065391594715;4613.446386433649;4631.930521042187;5154.845354639367;5154.974225128851;5155.149400348975;5169.069567477815;5221.660592061504;4531.297648864432;4550.340200670884;4554.3851580036935;4557.475890272594;4613.215753321943;4548.818047278138;4693.272542755878;4717.938463845608;4749.786259618326;4768.237082066853;4911.87720306988;4913.484084171254;4921.68009079423;4944.579710724629;4986.80052797884;4991.675541089963;5161.509656582619;5162.793488260578;5163.66436181647;5220.791168353223;4945.381827271591;4961.975190124026;4982.078315511642;5013.072581572275;5042.218456139304;5089.9745501272255;5111.1311077117725;5111.565516931102;5123.487651234846;5168.612354073534;5045.344105266292;5158.896822063462;5181.715005674573;5190.948090519047;5197.922031169611;4809.278608208797;4937.481564435682;5016.473270306711;5050.368703912011;5087.669301495539;5015.348004759504;5043.924341134959;5045.823396181116;5065.442801291929;5085.669431486942;4701.459332176843;4934.111859865116;4969.204927211629;5005.974970125272;5036.219385995177;5001.049800537886;5095.802486415763;5099.464556221692;5120.48795120485;5161;4936.160852654985;4939.506049395031;4942.061008408535;4994.750262486788;5025.748712564284 01:44:25 INFO - PROCESS | 4776 | |1;ext.html;573.2977103048765;596.8865915476057;605.5155875299761;621.297933335331;636.9522285828564;25966.610500842504;33113.50329745056;33834.830825845835;34047.65952340479;34048.148796280104;34879.30241395171;35586.8220658897;35610.2877942441;35613;35644.643553564456;7403.962980185105;7529;7551.395888328921;7591.089069311663;7632.465727399084;7469.253074692541;7546.169921308651;7552.244775522458;7599;7610.048743907012;7726.304632583066;7790.883136752925;7794.610269486531;7797.103333116679;7807.453478256524;7681.57751323677;7753.689852405925;7759.2240775921955;7768.689252429896;7774.53352798831;7569.545827250383;7646.923530764677;7656.272654097907;7656.61716914152;7667.424943129232;34780.478292825625;35238;35308.82345588256;35407.1148221294;35440;2930.074149425798;3015.035188739604;3017.607710997578;3223.725983291423;3340.5991281046186;26284.605730914052;26948.461030779275;26984.73015269842;26989.32526686829;27281;3439.3121375724954;3446.724262059029;3479.2693534357813;3580.910477238064;3589.6410358964154;147230;148887;149114;149466.50533494636;149747;29467.85266073656;30144.24639384033;49657.50342496601;50222.24666630004;50237.497625024014;30879.382412351628;30976.22559436032;31025.8448707755;31162.376752464825;31258.68741312558;13261.270630115243;13533.39099740514;13584.796228056586;13599.320033998261;13609.795853062213;11229.382383968798;11346.602868899714;11373.20387572862;11402.714932126763;11455.828162577567;7658.425618078666;7901.170377110436;7952.125266220711;7986;8000.51996880189;3074.0931425229164;3173.2066983254185;3178.4278829810855;3186.2353035271367;3190.5692731480954;874.606427107804;913.7441516375426;982.3761911186306;1045.6183493024992;1094.3980810554162;26543.734562654125;26599.468010640066;26668.733312666624;26747.592716655596;26996.1901142966;944.1266828183902;986.2997271937005;1011.1506334678758;1065.504540388723;1075.4461452352045;12681.619551413289;13411.597652070453;13461.798073028913;13494.392752326168;13509.324533773271;220008;223736;225147;226383;226470;45340.09319813585;45965.77017114893;46005.7699711506;46018.30972535415;46116.7694161527;1270.3775150176348;1285.8135570342436;1291.8837304642627;1300.4213125159213;1307.9607611771662;24985.625215622145;26395.736042639328;26398.20805375842;26928.192154235403;27092.593611095454;38694.80652596719;39525.2094958105;39567.2086558273;39757.80121099376;39932.20135597214;251652;252324;252335;253218;254572;23013.65479517775;24068.39829004289;24241.51516969686;24285.878570607034;24311.149109781072;35260.64739352574;37215.62784372122;37744.433833491974;38329.4250586247;38572.2285554293;30226.395472090873;30718.078457646305;30856.845715771276;30920.536191957588;31043.223919402197;31651.683483164874;33023.834880825445;33186.33627327488;33304.1673958153;33377.33245335031;26890.32774180661;30774.538381924736;31350.68649313569;33100.503492448115;33419;28019.719802801712;29069;30723.231919201306;31000.379992399576;31102.68897310998;23210.88394558084;23626;23901.521969560858;23944.161954331514;23947.004251449536 01:44:25 INFO - PROCESS | 4776 | |2;jquery.html;380.24331580155484;388.69487452349904;390.95113110861126;393.3568615313961;409.9467069280993;14618.195999220052;15782.289796959136;15805.84194158058;15853;15982.12098334591;15148.242587870618;15503.379864805422;16402.425915092976;16406.26171822268;16430.342786288566;4545.863624091283;5088.313077734496;5092.9745351273195;5097.464766199551;5113.667611605252;3662.761920475174;5448.645838020516;5773.134029895507;5819.418058194189;5843.18195452637;5425.755840987145;5718.456746609087;5759.913601295984;5769.596128271022;5777.306723193223;5731.799387021455;5737.3975732548315;5745.253117094772;5750.137479378085;5765.740541675635;4862.902741945141;4944.703317800908;4961.5286547777905;4973.4280557735965;5120.487951204887;19315;19369.12838922252;19434.514137146685;19591.80408195914;19596.902015489974;1836.1920754867815;1892.8864268143955;1937.0411646235063;2014.74815648044;2393.994522300638;12191.39043047853;12898.80651790224;13019.479220831156;13139.605811825564;13144.802827957492;1665.6585399993094;1746.6594014167242;1758.4636685810822;1771.052486919492;1823.6535058339007;54515.45484545144;57081.714591426775;57300.140497892564;57411.13883291754;57897.42102579005;9154.542272886329;9185.63257469707;9224.446533208029;9231.169194772503;9258.351915365995;12552.058595605184;12604.49582016709;12656.557020504239;12665.430055647334;12693.111482196342;7393.741219057307;7422.814429639302;7506.061742282215;7586.279303466162;7588.658510367047;7234.782956511313;7302.342789149002;7316.609844129598;7364.153122390993;7415.85168296631;5974.492168165754;6041.2750469943885;6044.455998960115;6044.879102417927;6060.727267272983;1666.9749953750704;1752.3954235788633;1861.8324350808493;1884.5948121154017;1900.4678689966831;849.8810166576684;936.194872409727;941.3363578677153;982.4498280962683;995.4226548601794;14986.925065374604;15075;15172.317245723969;15302.311395987208;16513.6697266054;872.829798189347;920.4891285336569;939.9953000234955;944.8582712593029;975.5366201054584;9420.90579094214;9467.573959171854;9539.14147726708;9563.139317461322;9734.41593504392;347757;348696;348883;358650;388598;54321.45678543243;60300.39699603036;62249;63347.6832615834;63461;910.2308549275851;930.02812061396;938.1650331205233;974.3033730882453;976.9413835169912;14078.155310681392;14135.505257315945;14186.219757913414;14492.058016228912;14578.343974521384;28541.28646783847;32289.192770180933;32504.512432313062;33375.33249334951;33748.66251337554;36115.458268126524;37337;38816;39439.408408874464;40943.976400590225;6870.553414028072;7138.357547820721;7159.319864612853;7220.638968051471;7494.138174110047;10968.287061340987;10972.725681858017;11001.394923279297;11248.606298779503;11261.66215013551;9736.41581505112;9852.113309801865;9910.603575857174;9992.900070999198;10109.848352274576;9805.2646051545;9957.302988790716;10065.194784417376;10173.23700722434;10227.43749093807;9345.48599827016;9974.40153590787;10117;10123.898761012295;10166.593336266467;7357.5217610855125;7629.504082234637;7641.88537171954;7719;7831.2560306770765;9257.629694812402;9791.902080979098;9953.950230248802;10090.54592543352;10094.507943964865 01:44:25 INFO - PROCESS | 4776 | |3;mootools.html;1439.4314245872881;1473.557932620214;1609.6217388913603;1736.800267969184;1788.3651303787155;6610.570312929668;7333.413326933845;7412.888806667905;7702.9614851925735;7727.034120734915;7363.300486453792;7454.993575867256;7463.738769143081;7474.103107627078;7475.140358858733;2168.2736283345057;2188.1903695632636;2189.8576592521513;2202.130158587357;2205.974221986776;2189.0805861538192;2206.5145667953025;2266.660000999847;2269.092363054783;2270.239469777618;2235.5417139486367;2254.0983606557343;2260.446190683285;2274.2722328854775;2277.1802151225547;2204.691343211952;2210.3037543173928;2212.9225477108384;2215.4572129828134;2216.312942987671;2083.468715477559;2099.391176558796;2100.0864623888656;2100.8949552522467;2103.1272022110957;7658.693652253904;7672.3478504327195;7700.306972372513;7718.729844455417;7735.110462296851;4636.443626764776;4767.189577771787;4789.616830653539;4805.951940480585;4812.302216178635;2976.523756198998;3064.9693503064905;3090.6909309069138;3094.3965926644314;3101.6743241959493;914.8216097860919;943.9103285187896;949.7815502434479;966.5650457294246;966.8308046091905;10091.69724908254;10143.188544916462;10155.79688406235;10158;10167.796644067077;4290.2706539888295;4292.506361768436;4363.36731173978;4384.276594361958;4386.122775444924;8864.64541418349;8871.423357481743;8888.955555222183;8898.73303800887;8906.02033776284;4758.547937945889;4783.612752301793;4802.159622066124;4802.975985120052;4814.181589129857;3757.1734218471893;4241.215375155544;4316.848910288125;4334.761588112621;4347.586979236968;3500.4049311617086;3556.626554211822;3558.5907620623443;3626.1478552540134;3648.7445878788762;1226.4971361741643;1240.1938739819009;1249.6563445052684;1257.415301884628;1263.065331654569;772.9652165652559;908.5911339896941;913.9543022848964;918.4168053286211;942.4769253064478;5346.385165705994;5407.215953686693;5419.539339156216;5478.287822583118;5638.2670252866865;427.55107137505496;430.9892252693645;433.18128736687686;436.4653299707833;440.9691321607457;3834.386498160337;3866.4586957825927;3885.8639947602264;3910.178862438863;3958.267720471722;8878.422902511316;9145;9146.496942668084;9199.402038867453;9222.631094756269;8817.07420720815;8848.159424854628;8991.325650576233;9012.63949442028;9059.320550958704;6998.860022799618;7013.193482749549;7055.294470553006;7071.116110486189;7086.433085353159;5130.179171332569;5220.738963051908;5231.764570594256;5304.443033481429;5448.972755136199;8312.501249925024;8342.416030877781;8535.146485351415;8674.002489713512;8693.04376518595;8275.875861862198;8605.483670979762;8612.009618893657;8652.048274689905;8866.77833054153;6062.909056364247;6387.105805187371;6437.452816510649;6572.112764776694;6582.76960306387;7120.786376408716;7144.142702875688;7199.676014579251;7212.4230061596;7213.855722885408;6320.62076275425;6547.181602299713;6622.933770662232;6624.238212605612;6661.034150048313;6372.330905255067;6413.390727880844;6423.229212494531;6430.5177111715875;6448.516361272829;6270.216222972129;6366.204224471941;6366.363363663597;6385.8722825544155;6388.552801303864;4477;4664.160451118695;4664.416947881515;4674.76626168697;4676.064787042673;4240.300350442266;4315.136972605429;4344.391785150145;4384.627306678968;4385.473743150842 01:44:25 INFO - PROCESS | 4776 | |4;prototype.html;300.1760168337912;303.2963524622874;310.4133188274161;310.55590505577015;312.3097953522715;4821.734804585746;4878.829240976566;4912.2386030165335;4921.950780492194;4923.483034281403;4850.757462126897;4894.97552512237;4900.436449808273;4909.116359055369;4910.508949105088;3639.3813051781194;3717.5353080864893;3861.9613803861885;3868.651821336079;3872.9736619795776;3856.8842934712;3879.1078052048047;3883.592222816606;3897.2010737798682;3901.2977664020605;3873.205992771489;3876.282887665777;3881.8835434936855;3882.611738826123;3896.7272290939645;3782.602826703184;3811.8284677189595;3862.208247309295;3864.787436690981;3868.3810590305416;3368.9157771055675;3387.305602351512;3397.3205358928312;3397.473391624302;3402.081438011723;4725.173094708447;4725.5510726480925;4726.7400292983875;4774.880627984294;4779.593734532569;4345.369921361416;4347.413099231627;4360.934585981213;4361.825526978917;4362.978185109086;4913.557779799835;5105.897882042338;5132.743362831843;5143.408508021551;5157.638965272433;3658.5975542690285;3687.9262414751825;3695.9630403695887;3700.093477098128;3703.6111208323277;5326.387465441485;5360.705161216131;5428.864278393033;5454.59090568205;5456.290682211326;3659.2315613721416;3739.2895349883433;3788.6590206881515;3806.5241844769403;3828.2534905693124;3826.1199924017073;3843.5010345965097;3852.9807350963065;3858.4212368145004;3864.9227015459533;4366.716163449366;4392.2094023075515;4399.23013472641;4401.119776044804;4404.273294906368;5024.346834911438;5096.413912400048;5128.282040514331;5165.9225111623355;5175.870603234949;1412.569166404236;1419.3116338575783;1421.623269833495;1424.2451500704642;1425;888.5424006636588;944.593824655391;966.8453047512364;971.5482300730054;983.5672304186278;4470.374147619336;4612.492625811158;4644.651651126179;4655.114678555191;4664.183767840615;5292.576593872558;5308.548773354308;5334.359876814807;5347;5351.732413379315;4459.420275364182;4600.205919691323;4633.189191891405;4635.374224479652;4651.023285110165;2994.6705862355125;3015.62304711911;3048.6189226346705;3057.1592811976884;3060.2502386914903;5390.676559406448;5416.295881535375;5424.752306969419;5430.239766432703;5437.782488700487;5168.767405466763;5479.808206712825;5508.779648814083;5790.478856902899;5809.622374545641;5091.439941606494;5109.489051094861;5111.233315002705;5123.7199446246805;5163.483651634807;5355.9464405357;5388.272583201375;5396.487333703292;5402.27069345649;5418.241446197457;5119.872003199801;5260.158374660036;5267.499587539178;5293.497117773805;5310.256564080954;5118.97440512795;5135;5146.408163061295;5148.90661923764;5161.793528258828;3660.6339366064244;3742.569604495518;3743.2139250757646;3747.3254814133716;3767.7174211933666;5124.410692770379;5387.946120538744;5425.701586412785;5440.782368705366;5447.412479072409;5205.921911171411;5207.6875387476875;5238.68567885928;5253.058287359091;5261.631685781958;5144.588432925282;5204.297419848272;5221.477852214748;5242.659227150223;5259.447757985509;5034.4462109167225;5118.8720281991755;5158.690478571298;5159.896802064013;5162.148245539444;4938.802447902188;5021.774020169174;5145.382554093533;5230.738463076755;5256.39551451588;5009.0983622948215;5058.974705126451;5069.138246498031;5071.695698257969;5094.2867998479505 01:44:25 INFO - PROCESS | 4776 | |5;yui.html;632.5525883932568;757.4470636435402;770.2220757035393;774.5546310871247;785.7839094249077;12311.569095081673;12454.564090256843;12486;12489.500419983202;12535;10726.410047447387;10789.19081068919;10800.459977001157;10801.56793728252;10845.83731244032;631.0471188505344;772.2856357868949;792.3225642076014;817.4155478832633;817.9918200818005;802.1016461563029;803.6945960534988;809.8663720486113;810.1250649298743;811.1969150540981;852.0244320253306;859.0764927702713;859.5745106172453;859.9011113721939;861.0098386855104;844.5481667307992;845.8984921809422;847.4322204123191;850.0946491986015;852.045708806138;618.2766163588612;620.2092332276338;623.6850390552787;624.0202881476084;624.5565648389603;12657.683557911127;12687.175333603287;12705.364731763468;12709.300988445631;12762;12497.687557811036;12706.745865082647;12707.93646031764;12792.61622151337;12946.287954162517;9382.812343753087;9601.951990240004;9766.414015159113;9826.557804898797;9940.90059099407;4171.561985991488;4181.205570941512;4221.894452638709;4229.49246090468;4231;45173.77413112913;46659.60230636413;46680.299795503095;47082;47151.5284847154;9671.564779584936;9722.659706910224;9814.607415703293;9847.261455390875;10035.79928401428;16961.406350777663;16986.065766382966;17000.319987200375;17039.829601703823;17096.48710538686;6917.550359226634;6937.3062693731235;6987.685554150075;7038.40173585251;7099.112610923635;3640.21735326906;3744.120131769032;3784.413415920537;3802.391617341212;3818.503594532693;2820.605115283862;2850.458412901542;2872.052222766482;2876.5685147228082;2879.337752316979;524.4100387064552;532.97068661224;533.4185737546015;534.9408171819819;536.8443151486103;541.3990470577655;556.3629644057531;609.6464050850497;627.8949049672518;664.2129077043719;8297.8340433191;8417.368697347723;8503.207910517825;8578.142185781497;8717.694880679273;542.9864253393697;550.0209626864188;610.4201009041428;619.2383368456823;637.2034956304619;3843.442700808367;3902.804859757001;3963.8612648557164;4002.399640053957;4071.75569465833;52155.21767173419;54767.72616136894;54969;55187.724061379435;55246.17130743042;47685.04629907382;48122.5187748125;48215;48509.5149048505;49255;44735.55264447314;44875.77562112234;45084.54915450804;45200.77399612981;45671.77164114158;7344.742933997284;7919.524828510308;8577.82844343122;8708.433951793113;8761.342899282452;29434.85282573659;30376.696233037386;30459.69540304657;30976.60605272723;31459.213519662193;40962.590374095875;42131;42132.57867421286;42266.788666056476;42470;10770.892291077302;10879.456027198767;10937.398443085707;11320.773584528428;11593.536258549564;11902.226355286879;11936.224145430519;11955.64133076009;12063.21589096706;12317.568885089337;11125.499352529318;11129.83305250438;11180.161487888277;11570.710732231762;12236.510539578318;11302.886971130183;11542.249753765978;11824.172307938361;11831.645050648494;12135.575254866037;11095.611653592085;11467.369294688539;11498.25261358009;11541.82687259675;11639;9319.301052421231;9339.673111441067;9557.713268601952;9893;10163.898361016296;9470.715878523655;9548.37935534188;10244.282900196915;10264.794704106025;10266.435346056038 01:44:25 INFO - PROCESS | 4776 | __end_tp_report 01:44:25 INFO - PROCESS | 4776 | __start_cc_report 01:44:25 INFO - PROCESS | 4776 | _x_x_mozilla_cycle_collect,401 01:44:25 INFO - PROCESS | 4776 | __end_cc_report 01:44:25 INFO - PROCESS | 4776 | __startTimestamp1461833065161__endTimestamp 01:44:25 INFO - PROCESS | 4776 | 01:44:25 INFO - PROCESS | 4776 | ------- Summary: start ------- 01:44:25 INFO - PROCESS | 4776 | Number of tests: 6 01:44:25 INFO - PROCESS | 4776 | 01:44:25 INFO - PROCESS | 4776 | [#0] dojo.html Cycles:165 Average:4779.94 Median:4936.16 stddev:524.51 (10.6%) stddev-sans-first:498.74 01:44:25 INFO - PROCESS | 4776 | Values: 2648.0 2722.6 2749.5 2750.2 2758.1 4803.1 4808.2 4840.4 4873.6 4902.8 4776.8 4809.5 4857.0 4898.3 4899.3 4377.3 4446.3 4493.5 4498.1 4500.0 4430.6 4548.5 4561.9 4584.4 4592.4 4357.9 4396.8 4457.2 4486.1 4549.8 4458.3 4485.4 4493.0 4496.3 4535.9 4426.8 4434.3 4437.8 4458.3 4478.3 4707.4 4747.8 4811.3 4815.0 4868.0 5137.4 5170.6 5173.8 5174.6 5191.3 5086.8 5211.9 5217.6 5219.4 5222.8 4749.1 4761.9 4787.8 4821.6 4840.3 5312.2 5428.3 5446.4 5446.9 5482.3 4924.4 5036.7 5172.5 5193.6 5208.5 5093.0 5180.1 5207.3 5210.9 5262.3 4994.8 5140.7 5195.5 5204.5 5252.0 4936.7 5148.4 5156.0 5160.0 5165.7 4012.0 4018.6 4033.1 4050.6 4062.5 3564.7 3569.8 3575.3 3594.5 3609.8 4520.7 4551.1 4559.1 4613.4 4631.9 5154.8 5155.0 5155.1 5169.1 5221.7 4531.3 4550.3 4554.4 4557.5 4613.2 4548.8 4693.3 4717.9 4749.8 4768.2 4911.9 4913.5 4921.7 4944.6 4986.8 4991.7 5161.5 5162.8 5163.7 5220.8 4945.4 4962.0 4982.1 5013.1 5042.2 5090.0 5111.1 5111.6 5123.5 5168.6 5045.3 5158.9 5181.7 5190.9 5197.9 4809.3 4937.5 5016.5 5050.4 5087.7 5015.3 5043.9 5045.8 5065.4 5085.7 4701.5 4934.1 4969.2 5006.0 5036.2 5001.0 5095.8 5099.5 5120.5 5161.0 4936.2 4939.5 4942.1 4994.8 5025.7 01:44:25 INFO - PROCESS | 4776 | 01:44:25 INFO - PROCESS | 4776 | [#1] ext.html Cycles:180 Average:35423.21 Median:17412.45 stddev:55618.43 (319.4%) stddev-sans-first:55712.90 01:44:25 INFO - PROCESS | 4776 | Values: 573.3 596.9 605.5 621.3 637.0 25966.6 33113.5 33834.8 34047.7 34048.1 34879.3 35586.8 35610.3 35613.0 35644.6 7404.0 7529.0 7551.4 7591.1 7632.5 7469.3 7546.2 7552.2 7599.0 7610.0 7726.3 7790.9 7794.6 7797.1 7807.5 7681.6 7753.7 7759.2 7768.7 7774.5 7569.5 7646.9 7656.3 7656.6 7667.4 34780.5 35238.0 35308.8 35407.1 35440.0 2930.1 3015.0 3017.6 3223.7 3340.6 26284.6 26948.5 26984.7 26989.3 27281.0 3439.3 3446.7 3479.3 3580.9 3589.6 147230.0 148887.0 149114.0 149466.5 149747.0 29467.9 30144.2 49657.5 50222.2 50237.5 30879.4 30976.2 31025.8 31162.4 31258.7 13261.3 13533.4 13584.8 13599.3 13609.8 11229.4 11346.6 11373.2 11402.7 11455.8 7658.4 7901.2 7952.1 7986.0 8000.5 3074.1 3173.2 3178.4 3186.2 3190.6 874.6 913.7 982.4 1045.6 1094.4 26543.7 26599.5 26668.7 26747.6 26996.2 944.1 986.3 1011.2 1065.5 1075.4 12681.6 13411.6 13461.8 13494.4 13509.3 220008.0 223736.0 225147.0 226383.0 226470.0 45340.1 45965.8 46005.8 46018.3 46116.8 1270.4 1285.8 1291.9 1300.4 1308.0 24985.6 26395.7 26398.2 26928.2 27092.6 38694.8 39525.2 39567.2 39757.8 39932.2 251652.0 252324.0 252335.0 253218.0 254572.0 23013.7 24068.4 24241.5 24285.9 24311.1 35260.6 37215.6 37744.4 38329.4 38572.2 30226.4 30718.1 30856.8 30920.5 31043.2 31651.7 33023.8 33186.3 33304.2 33377.3 26890.3 30774.5 31350.7 33100.5 33419.0 28019.7 29069.0 30723.2 31000.4 31102.7 23210.9 23626.0 23901.5 23944.2 23947.0 01:44:25 INFO - PROCESS | 4776 | 01:44:25 INFO - PROCESS | 4776 | [#2] jquery.html Cycles:180 Average:22048.51 Median:5090.64 stddev:58730.16 (1153.7%) stddev-sans-first:58872.38 01:44:25 INFO - PROCESS | 4776 | Values: 380.2 388.7 391.0 393.4 409.9 14618.2 15782.3 15805.8 15853.0 15982.1 15148.2 15503.4 16402.4 16406.3 16430.3 4545.9 5088.3 5093.0 5097.5 5113.7 3662.8 5448.6 5773.1 5819.4 5843.2 5425.8 5718.5 5759.9 5769.6 5777.3 5731.8 5737.4 5745.3 5750.1 5765.7 4862.9 4944.7 4961.5 4973.4 5120.5 19315.0 19369.1 19434.5 19591.8 19596.9 1836.2 1892.9 1937.0 2014.7 2394.0 12191.4 12898.8 13019.5 13139.6 13144.8 1665.7 1746.7 1758.5 1771.1 1823.7 54515.5 57081.7 57300.1 57411.1 57897.4 9154.5 9185.6 9224.4 9231.2 9258.4 12552.1 12604.5 12656.6 12665.4 12693.1 7393.7 7422.8 7506.1 7586.3 7588.7 7234.8 7302.3 7316.6 7364.2 7415.9 5974.5 6041.3 6044.5 6044.9 6060.7 1667.0 1752.4 1861.8 1884.6 1900.5 849.9 936.2 941.3 982.4 995.4 14986.9 15075.0 15172.3 15302.3 16513.7 872.8 920.5 940.0 944.9 975.5 9420.9 9467.6 9539.1 9563.1 9734.4 347757.0 348696.0 348883.0 358650.0 388598.0 54321.5 60300.4 62249.0 63347.7 63461.0 910.2 930.0 938.2 974.3 976.9 14078.2 14135.5 14186.2 14492.1 14578.3 28541.3 32289.2 32504.5 33375.3 33748.7 36115.5 37337.0 38816.0 39439.4 40944.0 6870.6 7138.4 7159.3 7220.6 7494.1 10968.3 10972.7 11001.4 11248.6 11261.7 9736.4 9852.1 9910.6 9992.9 10109.8 9805.3 9957.3 10065.2 10173.2 10227.4 9345.5 9974.4 10117.0 10123.9 10166.6 7357.5 7629.5 7641.9 7719.0 7831.3 9257.6 9791.9 9954.0 10090.5 10094.5 01:44:25 INFO - PROCESS | 4776 | 01:44:25 INFO - PROCESS | 4776 | [#3] mootools.html Cycles:180 Average:5031.16 Median:5175.46 stddev:2714.21 (52.4%) stddev-sans-first:2708.40 01:44:25 INFO - PROCESS | 4776 | Values: 1439.4 1473.6 1609.6 1736.8 1788.4 6610.6 7333.4 7412.9 7703.0 7727.0 7363.3 7455.0 7463.7 7474.1 7475.1 2168.3 2188.2 2189.9 2202.1 2206.0 2189.1 2206.5 2266.7 2269.1 2270.2 2235.5 2254.1 2260.4 2274.3 2277.2 2204.7 2210.3 2212.9 2215.5 2216.3 2083.5 2099.4 2100.1 2100.9 2103.1 7658.7 7672.3 7700.3 7718.7 7735.1 4636.4 4767.2 4789.6 4806.0 4812.3 2976.5 3065.0 3090.7 3094.4 3101.7 914.8 943.9 949.8 966.6 966.8 10091.7 10143.2 10155.8 10158.0 10167.8 4290.3 4292.5 4363.4 4384.3 4386.1 8864.6 8871.4 8889.0 8898.7 8906.0 4758.5 4783.6 4802.2 4803.0 4814.2 3757.2 4241.2 4316.8 4334.8 4347.6 3500.4 3556.6 3558.6 3626.1 3648.7 1226.5 1240.2 1249.7 1257.4 1263.1 773.0 908.6 914.0 918.4 942.5 5346.4 5407.2 5419.5 5478.3 5638.3 427.6 431.0 433.2 436.5 441.0 3834.4 3866.5 3885.9 3910.2 3958.3 8878.4 9145.0 9146.5 9199.4 9222.6 8817.1 8848.2 8991.3 9012.6 9059.3 6998.9 7013.2 7055.3 7071.1 7086.4 5130.2 5220.7 5231.8 5304.4 5449.0 8312.5 8342.4 8535.1 8674.0 8693.0 8275.9 8605.5 8612.0 8652.0 8866.8 6062.9 6387.1 6437.5 6572.1 6582.8 7120.8 7144.1 7199.7 7212.4 7213.9 6320.6 6547.2 6622.9 6624.2 6661.0 6372.3 6413.4 6423.2 6430.5 6448.5 6270.2 6366.2 6366.4 6385.9 6388.6 4477.0 4664.2 4664.4 4674.8 4676.1 4240.3 4315.1 4344.4 4384.6 4385.5 01:44:25 INFO - PROCESS | 4776 | 01:44:25 INFO - PROCESS | 4776 | [#4] prototype.html Cycles:180 Average:4332.13 Median:4909.81 stddev:1247.61 (25.4%) stddev-sans-first:1213.85 01:44:25 INFO - PROCESS | 4776 | Values: 300.2 303.3 310.4 310.6 312.3 4821.7 4878.8 4912.2 4922.0 4923.5 4850.8 4895.0 4900.4 4909.1 4910.5 3639.4 3717.5 3862.0 3868.7 3873.0 3856.9 3879.1 3883.6 3897.2 3901.3 3873.2 3876.3 3881.9 3882.6 3896.7 3782.6 3811.8 3862.2 3864.8 3868.4 3368.9 3387.3 3397.3 3397.5 3402.1 4725.2 4725.6 4726.7 4774.9 4779.6 4345.4 4347.4 4360.9 4361.8 4363.0 4913.6 5105.9 5132.7 5143.4 5157.6 3658.6 3687.9 3696.0 3700.1 3703.6 5326.4 5360.7 5428.9 5454.6 5456.3 3659.2 3739.3 3788.7 3806.5 3828.3 3826.1 3843.5 3853.0 3858.4 3864.9 4366.7 4392.2 4399.2 4401.1 4404.3 5024.3 5096.4 5128.3 5165.9 5175.9 1412.6 1419.3 1421.6 1424.2 1425.0 888.5 944.6 966.8 971.5 983.6 4470.4 4612.5 4644.7 4655.1 4664.2 5292.6 5308.5 5334.4 5347.0 5351.7 4459.4 4600.2 4633.2 4635.4 4651.0 2994.7 3015.6 3048.6 3057.2 3060.3 5390.7 5416.3 5424.8 5430.2 5437.8 5168.8 5479.8 5508.8 5790.5 5809.6 5091.4 5109.5 5111.2 5123.7 5163.5 5355.9 5388.3 5396.5 5402.3 5418.2 5119.9 5260.2 5267.5 5293.5 5310.3 5119.0 5135.0 5146.4 5148.9 5161.8 3660.6 3742.6 3743.2 3747.3 3767.7 5124.4 5387.9 5425.7 5440.8 5447.4 5205.9 5207.7 5238.7 5253.1 5261.6 5144.6 5204.3 5221.5 5242.7 5259.4 5034.4 5118.9 5158.7 5159.9 5162.1 4938.8 5021.8 5145.4 5230.7 5256.4 5009.1 5059.0 5069.1 5071.7 5094.3 01:44:25 INFO - PROCESS | 4776 | 01:44:25 INFO - PROCESS | 4776 | [#5] yui.html Cycles:180 Average:13181.33 Median:46165.69 stddev:15076.57 (32.7%) stddev-sans-first:15089.41 01:44:25 INFO - PROCESS | 4776 | Values: 632.6 757.4 770.2 774.6 785.8 12311.6 12454.6 12486.0 12489.5 12535.0 10726.4 10789.2 10800.5 10801.6 10845.8 631.0 772.3 792.3 817.4 818.0 802.1 803.7 809.9 810.1 811.2 852.0 859.1 859.6 859.9 861.0 844.5 845.9 847.4 850.1 852.0 618.3 620.2 623.7 624.0 624.6 12657.7 12687.2 12705.4 12709.3 12762.0 12497.7 12706.7 12707.9 12792.6 12946.3 9382.8 9602.0 9766.4 9826.6 9940.9 4171.6 4181.2 4221.9 4229.5 4231.0 45173.8 46659.6 46680.3 47082.0 47151.5 9671.6 9722.7 9814.6 9847.3 10035.8 16961.4 16986.1 17000.3 17039.8 17096.5 6917.6 6937.3 6987.7 7038.4 7099.1 3640.2 3744.1 3784.4 3802.4 3818.5 2820.6 2850.5 2872.1 2876.6 2879.3 524.4 533.0 533.4 534.9 536.8 541.4 556.4 609.6 627.9 664.2 8297.8 8417.4 8503.2 8578.1 8717.7 543.0 550.0 610.4 619.2 637.2 3843.4 3902.8 3963.9 4002.4 4071.8 52155.2 54767.7 54969.0 55187.7 55246.2 47685.0 48122.5 48215.0 48509.5 49255.0 44735.6 44875.8 45084.5 45200.8 45671.8 7344.7 7919.5 8577.8 8708.4 8761.3 29434.9 30376.7 30459.7 30976.6 31459.2 40962.6 42131.0 42132.6 42266.8 42470.0 10770.9 10879.5 10937.4 11320.8 11593.5 11902.2 11936.2 11955.6 12063.2 12317.6 11125.5 11129.8 11180.2 11570.7 12236.5 11302.9 11542.2 11824.2 11831.6 12135.6 11095.6 11467.4 11498.3 11541.8 11639.0 9319.3 9339.7 9557.7 9893.0 10163.9 9470.7 9548.4 10244.3 10264.8 10266.4 01:44:25 INFO - PROCESS | 4776 | -------- Summary: end -------- 01:44:25 INFO - PROCESS | 4776 | 01:44:25 INFO - TEST-INFO | 4776: exit 0 01:44:25 INFO - TEST-OK | dromaeo_css | took 1115559ms 01:44:25 INFO - TEST-START | kraken 01:44:25 INFO - operating with platform_type : linux_ 01:44:25 INFO - Initialising browser for kraken test... 01:44:25 INFO - TEST-INFO | started process 5008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPKW7yg/profile http://localhost:44299/getInfo.html) 01:44:29 INFO - PROCESS | 5008 | 01:44:29 INFO - PROCESS | 5008 | (process:5076): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:44:30 INFO - PROCESS | 5008 | __metrics Screen width/height:1600/1200 01:44:30 INFO - PROCESS | 5008 | colorDepth:24 01:44:30 INFO - PROCESS | 5008 | Browser inner width/height: 1024/697 01:44:30 INFO - PROCESS | 5008 | __metrics 01:44:31 ERROR - PROCESS | 5008 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 01:44:32 INFO - TEST-INFO | 5008: exit 0 01:44:32 INFO - Browser initialized. 01:44:32 INFO - Running cycle 1/1 for kraken test... 01:44:32 INFO - TEST-INFO | started process 5127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPKW7yg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:44:34 INFO - PROCESS | 5127 | 01:44:34 INFO - PROCESS | 5127 | (process:5189): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:44:44 INFO - PROCESS | 5127 | RSS: Main: 166322176 01:44:44 INFO - PROCESS | 5127 | 01:44:47 INFO - PROCESS | 5127 | Cycle 1(1): loaded http://localhost:44299/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44299/tests/kraken/driver.html?testName=audio-beat-detection) 01:44:48 INFO - PROCESS | 5127 | RSS: Main: 169771008 01:44:48 INFO - PROCESS | 5127 | 01:44:50 INFO - PROCESS | 5127 | Cycle 1(1): loaded http://localhost:44299/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44299/tests/kraken/driver.html?testName=audio-dft) 01:44:51 INFO - PROCESS | 5127 | RSS: Main: 172888064 01:44:51 INFO - PROCESS | 5127 | 01:44:54 INFO - PROCESS | 5127 | Cycle 1(1): loaded http://localhost:44299/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44299/tests/kraken/driver.html?testName=audio-fft) 01:44:55 INFO - PROCESS | 5127 | RSS: Main: 164462592 01:44:55 INFO - PROCESS | 5127 | 01:44:57 INFO - PROCESS | 5127 | Cycle 1(1): loaded http://localhost:44299/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44299/tests/kraken/driver.html?testName=audio-oscillator) 01:44:57 INFO - PROCESS | 5127 | RSS: Main: 165371904 01:44:57 INFO - PROCESS | 5127 | 01:45:00 INFO - PROCESS | 5127 | Cycle 1(1): loaded http://localhost:44299/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44299/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:45:00 INFO - PROCESS | 5127 | RSS: Main: 166338560 01:45:00 INFO - PROCESS | 5127 | 01:45:03 INFO - PROCESS | 5127 | Cycle 1(1): loaded http://localhost:44299/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44299/tests/kraken/driver.html?testName=imaging-darkroom) 01:45:04 INFO - PROCESS | 5127 | RSS: Main: 166207488 01:45:04 INFO - PROCESS | 5127 | 01:45:08 INFO - PROCESS | 5127 | Cycle 1(1): loaded http://localhost:44299/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44299/tests/kraken/driver.html?testName=imaging-desaturate) 01:45:08 INFO - PROCESS | 5127 | RSS: Main: 165916672 01:45:08 INFO - PROCESS | 5127 | 01:45:11 INFO - PROCESS | 5127 | Cycle 1(1): loaded http://localhost:44299/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44299/tests/kraken/driver.html?testName=json-parse-financial) 01:45:12 INFO - PROCESS | 5127 | RSS: Main: 166785024 01:45:12 INFO - PROCESS | 5127 | 01:45:13 INFO - PROCESS | 5127 | Cycle 1(1): loaded http://localhost:44299/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44299/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:45:14 INFO - PROCESS | 5127 | RSS: Main: 167313408 01:45:14 INFO - PROCESS | 5127 | 01:45:16 INFO - PROCESS | 5127 | Cycle 1(1): loaded http://localhost:44299/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44299/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:45:17 INFO - PROCESS | 5127 | RSS: Main: 166952960 01:45:17 INFO - PROCESS | 5127 | 01:45:19 INFO - PROCESS | 5127 | Cycle 1(1): loaded http://localhost:44299/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44299/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:45:19 INFO - PROCESS | 5127 | RSS: Main: 167268352 01:45:19 INFO - PROCESS | 5127 | 01:45:22 INFO - PROCESS | 5127 | Cycle 1(1): loaded http://localhost:44299/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:45:23 INFO - PROCESS | 5127 | RSS: Main: 168030208 01:45:23 INFO - PROCESS | 5127 | 01:45:26 INFO - PROCESS | 5127 | Cycle 1(1): loaded http://localhost:44299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:45:27 INFO - PROCESS | 5127 | RSS: Main: 167149568 01:45:27 INFO - PROCESS | 5127 | 01:45:29 INFO - PROCESS | 5127 | Cycle 1(1): loaded http://localhost:44299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44299/tests/kraken/driver.html?testName=ai-astar) 01:45:29 INFO - PROCESS | 5127 | RSS: Main: 168587264 01:45:29 INFO - PROCESS | 5127 | 01:45:29 INFO - PROCESS | 5127 | __start_tp_report 01:45:29 INFO - PROCESS | 5127 | _x_x_mozilla_page_load 01:45:29 INFO - PROCESS | 5127 | _x_x_mozilla_page_load_details 01:45:29 INFO - PROCESS | 5127 | |i|pagename|runs| 01:45:29 INFO - PROCESS | 5127 | |0;ai-astar;114;108;112;113;114;126;111;113;112;112 01:45:29 INFO - PROCESS | 5127 | |1;audio-beat-detection;167;131;158;191;139;169;167;135;202;130 01:45:29 INFO - PROCESS | 5127 | |2;audio-dft;163;162;164;177;163;163;164;163;170;162 01:45:29 INFO - PROCESS | 5127 | |3;audio-fft;74;74;77;160;76;77;77;74;163;75 01:45:29 INFO - PROCESS | 5127 | |4;audio-oscillator;95;95;146;98;95;95;142;94;94;142 01:45:29 INFO - PROCESS | 5127 | |5;imaging-gaussian-blur;117;119;118;118;120;118;117;118;118;118 01:45:29 INFO - PROCESS | 5127 | |6;imaging-darkroom;147;147;148;149;147;147;147;146;148;146 01:45:29 INFO - PROCESS | 5127 | |7;imaging-desaturate;95;96;96;97;96;95;95;97;95;96 01:45:29 INFO - PROCESS | 5127 | |8;json-parse-financial;66;66;65;66;64;67;67;82;64;63 01:45:29 INFO - PROCESS | 5127 | |9;json-stringify-tinderbox;65;65;65;65;65;64;65;65;65;67 01:45:29 INFO - PROCESS | 5127 | |10;stanford-crypto-aes;81;80;78;79;82;79;81;80;90;83 01:45:29 INFO - PROCESS | 5127 | |11;stanford-crypto-ccm;142;135;144;138;134;143;133;131;166;136 01:45:29 INFO - PROCESS | 5127 | |12;stanford-crypto-pbkdf2;223;214;217;221;215;215;216;215;218;215 01:45:29 INFO - PROCESS | 5127 | |13;stanford-crypto-sha256-iterative;75;77;74;74;75;76;73;74;74;76 01:45:29 INFO - PROCESS | 5127 | __end_tp_report 01:45:29 INFO - PROCESS | 5127 | __start_cc_report 01:45:29 INFO - PROCESS | 5127 | _x_x_mozilla_cycle_collect,957 01:45:29 INFO - PROCESS | 5127 | __end_cc_report 01:45:29 INFO - PROCESS | 5127 | __startTimestamp1461833129495__endTimestamp 01:45:29 INFO - PROCESS | 5127 | 01:45:29 INFO - PROCESS | 5127 | ------- Summary: start ------- 01:45:29 INFO - PROCESS | 5127 | Number of tests: 14 01:45:29 INFO - PROCESS | 5127 | 01:45:29 INFO - PROCESS | 5127 | [#0] ai-astar Cycles:10 Average:113.50 Median:113.00 stddev:4.72 (4.2%) stddev-sans-first:5.00 01:45:29 INFO - PROCESS | 5127 | Values: 114.0 108.0 112.0 113.0 114.0 126.0 111.0 113.0 112.0 112.0 01:45:29 INFO - PROCESS | 5127 | 01:45:29 INFO - PROCESS | 5127 | [#1] audio-beat-detection Cycles:10 Average:158.90 Median:167.00 stddev:25.17 (15.1%) stddev-sans-first:26.53 01:45:29 INFO - PROCESS | 5127 | Values: 167.0 131.0 158.0 191.0 139.0 169.0 167.0 135.0 202.0 130.0 01:45:29 INFO - PROCESS | 5127 | 01:45:29 INFO - PROCESS | 5127 | [#2] audio-dft Cycles:10 Average:165.10 Median:163.50 stddev:4.77 (2.9%) stddev-sans-first:5.00 01:45:29 INFO - PROCESS | 5127 | Values: 163.0 162.0 164.0 177.0 163.0 163.0 164.0 163.0 170.0 162.0 01:45:29 INFO - PROCESS | 5127 | 01:45:29 INFO - PROCESS | 5127 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.50 stddev:36.29 (48.1%) stddev-sans-first:37.85 01:45:29 INFO - PROCESS | 5127 | Values: 74.0 74.0 77.0 160.0 76.0 77.0 77.0 74.0 163.0 75.0 01:45:29 INFO - PROCESS | 5127 | 01:45:29 INFO - PROCESS | 5127 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:95.00 stddev:23.33 (24.6%) stddev-sans-first:24.14 01:45:29 INFO - PROCESS | 5127 | Values: 95.0 95.0 146.0 98.0 95.0 95.0 142.0 94.0 94.0 142.0 01:45:29 INFO - PROCESS | 5127 | 01:45:29 INFO - PROCESS | 5127 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.83 01:45:29 INFO - PROCESS | 5127 | Values: 117.0 119.0 118.0 118.0 120.0 118.0 117.0 118.0 118.0 118.0 01:45:29 INFO - PROCESS | 5127 | 01:45:29 INFO - PROCESS | 5127 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 01:45:29 INFO - PROCESS | 5127 | Values: 147.0 147.0 148.0 149.0 147.0 147.0 147.0 146.0 148.0 146.0 01:45:29 INFO - PROCESS | 5127 | 01:45:29 INFO - PROCESS | 5127 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 01:45:29 INFO - PROCESS | 5127 | Values: 95.0 96.0 96.0 97.0 96.0 95.0 95.0 97.0 95.0 96.0 01:45:29 INFO - PROCESS | 5127 | 01:45:29 INFO - PROCESS | 5127 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:66.00 stddev:5.44 (8.2%) stddev-sans-first:5.75 01:45:29 INFO - PROCESS | 5127 | Values: 66.0 66.0 65.0 66.0 64.0 67.0 67.0 82.0 64.0 63.0 01:45:29 INFO - PROCESS | 5127 | 01:45:29 INFO - PROCESS | 5127 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 01:45:29 INFO - PROCESS | 5127 | Values: 65.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 67.0 01:45:29 INFO - PROCESS | 5127 | 01:45:29 INFO - PROCESS | 5127 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.00 stddev:3.40 (4.2%) stddev-sans-first:3.61 01:45:29 INFO - PROCESS | 5127 | Values: 81.0 80.0 78.0 79.0 82.0 79.0 81.0 80.0 90.0 83.0 01:45:29 INFO - PROCESS | 5127 | 01:45:29 INFO - PROCESS | 5127 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:140.00 stddev:10.09 (7.2%) stddev-sans-first:10.68 01:45:29 INFO - PROCESS | 5127 | Values: 142.0 135.0 144.0 138.0 134.0 143.0 133.0 131.0 166.0 136.0 01:45:29 INFO - PROCESS | 5127 | 01:45:29 INFO - PROCESS | 5127 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:216.90 Median:216.50 stddev:2.96 (1.4%) stddev-sans-first:2.17 01:45:29 INFO - PROCESS | 5127 | Values: 223.0 214.0 217.0 221.0 215.0 215.0 216.0 215.0 218.0 215.0 01:45:29 INFO - PROCESS | 5127 | 01:45:29 INFO - PROCESS | 5127 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:75.00 stddev:1.23 (1.6%) stddev-sans-first:1.30 01:45:29 INFO - PROCESS | 5127 | Values: 75.0 77.0 74.0 74.0 75.0 76.0 73.0 74.0 74.0 76.0 01:45:29 INFO - PROCESS | 5127 | -------- Summary: end -------- 01:45:29 INFO - PROCESS | 5127 | 01:45:30 INFO - TEST-INFO | 5127: exit 0 01:45:30 INFO - TEST-OK | kraken | took 64674ms 01:45:30 INFO - SUITE-END | took 1180s 01:45:30 INFO - Completed test suite (00:19:40) 01:45:30 INFO - javascript benchmark 01:45:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2647.9602805957907, 2722.6052222427747, 2749.450109978005, 2750.1612008337447, 2758.103616324695, 4803.111424386491, 4808.158572249851, 4840.443349014864, 4873.585745211657, 4902.779374928128, 4776.808927642899, 4809.495003024685, 4856.951430485694, 4898.338724272222, 4899.289603007562, 4377.343398490228, 4446.3108218226225, 4493.505714371417, 4498.100379924012, 4500.0, 4430.55694430556, 4548.454185497745, 4561.863144105666, 4584.381108550353, 4592.448906131269, 4357.869263922087, 4396.802143903532, 4457.175422546839, 4486.057927835142, 4549.840755573572, 4458.264386376244, 4485.3944717463055, 4492.9775351123035, 4496.325551167319, 4535.886602834922, 4426.800793964279, 4434.268345722952, 4437.755923424211, 4458.264386376244, 4478.283474644041, 4707.411573553306, 4747.786349614241, 4811.302361157613, 4815.0, 4867.951320486785, 5137.40919794221, 5170.586353091781, 5173.81891633791, 5174.611904107207, 5191.325127733408, 5086.821961231376, 5211.895762084737, 5217.58259339252, 5219.42586315505, 5222.817201397933, 4749.145153872267, 4761.904761904742, 4787.832425865147, 4821.590164835993, 4840.322354870321, 5312.1766126250495, 5428.321459817523, 5446.428125046892, 5446.891062178814, 5482.259894914136, 4924.384451943507, 5036.6726162799305, 5172.482751724798, 5193.610479214074, 5208.5051920067535, 5092.955944031539, 5180.145276029489, 5207.270982062514, 5210.895782084337, 5262.2632831403635, 4994.750262486934, 5140.742962851842, 5195.454477279907, 5204.505571970657, 5252.0, 4936.703797772073, 5148.382194136728, 5156.020356132323, 5159.96800639866, 5165.715885626327, 4011.9769458787823, 4018.598140185958, 4033.072393349546, 4050.5544390117066, 4062.532808726975, 3564.6791788739138, 3569.7679650822615, 3575.3206890690685, 3594.532710747586, 3609.8375573099274, 4520.660950428731, 4551.135284295973, 4559.065391594715, 4613.446386433649, 4631.930521042187, 5154.845354639367, 5154.974225128851, 5155.149400348975, 5169.069567477815, 5221.660592061504, 4531.297648864432, 4550.340200670884, 4554.3851580036935, 4557.475890272594, 4613.215753321943, 4548.818047278138, 4693.272542755878, 4717.938463845608, 4749.786259618326, 4768.237082066853, 4911.87720306988, 4913.484084171254, 4921.68009079423, 4944.579710724629, 4986.80052797884, 4991.675541089963, 5161.509656582619, 5162.793488260578, 5163.66436181647, 5220.791168353223, 4945.381827271591, 4961.975190124026, 4982.078315511642, 5013.072581572275, 5042.218456139304, 5089.9745501272255, 5111.1311077117725, 5111.565516931102, 5123.487651234846, 5168.612354073534, 5045.344105266292, 5158.896822063462, 5181.715005674573, 5190.948090519047, 5197.922031169611, 4809.278608208797, 4937.481564435682, 5016.473270306711, 5050.368703912011, 5087.669301495539, 5015.348004759504, 5043.924341134959, 5045.823396181116, 5065.442801291929, 5085.669431486942, 4701.459332176843, 4934.111859865116, 4969.204927211629, 5005.974970125272, 5036.219385995177, 5001.049800537886, 5095.802486415763, 5099.464556221692, 5120.48795120485, 5161.0, 4936.160852654985, 4939.506049395031, 4942.061008408535, 4994.750262486788, 5025.748712564284], "value": 4745.220234301185, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.2977103048765, 596.8865915476057, 605.5155875299761, 621.297933335331, 636.9522285828564, 25966.610500842504, 33113.50329745056, 33834.830825845835, 34047.65952340479, 34048.148796280104, 34879.30241395171, 35586.8220658897, 35610.2877942441, 35613.0, 35644.643553564456, 7403.962980185105, 7529.0, 7551.395888328921, 7591.089069311663, 7632.465727399084, 7469.253074692541, 7546.169921308651, 7552.244775522458, 7599.0, 7610.048743907012, 7726.304632583066, 7790.883136752925, 7794.610269486531, 7797.103333116679, 7807.453478256524, 7681.57751323677, 7753.689852405925, 7759.2240775921955, 7768.689252429896, 7774.53352798831, 7569.545827250383, 7646.923530764677, 7656.272654097907, 7656.61716914152, 7667.424943129232, 34780.478292825625, 35238.0, 35308.82345588256, 35407.1148221294, 35440.0, 2930.074149425798, 3015.035188739604, 3017.607710997578, 3223.725983291423, 3340.5991281046186, 26284.605730914052, 26948.461030779275, 26984.73015269842, 26989.32526686829, 27281.0, 3439.3121375724954, 3446.724262059029, 3479.2693534357813, 3580.910477238064, 3589.6410358964154, 147230.0, 148887.0, 149114.0, 149466.50533494636, 149747.0, 29467.85266073656, 30144.24639384033, 49657.50342496601, 50222.24666630004, 50237.497625024014, 30879.382412351628, 30976.22559436032, 31025.8448707755, 31162.376752464825, 31258.68741312558, 13261.270630115243, 13533.39099740514, 13584.796228056586, 13599.320033998261, 13609.795853062213, 11229.382383968798, 11346.602868899714, 11373.20387572862, 11402.714932126763, 11455.828162577567, 7658.425618078666, 7901.170377110436, 7952.125266220711, 7986.0, 8000.51996880189, 3074.0931425229164, 3173.2066983254185, 3178.4278829810855, 3186.2353035271367, 3190.5692731480954, 874.606427107804, 913.7441516375426, 982.3761911186306, 1045.6183493024992, 1094.3980810554162, 26543.734562654125, 26599.468010640066, 26668.733312666624, 26747.592716655596, 26996.1901142966, 944.1266828183902, 986.2997271937005, 1011.1506334678758, 1065.504540388723, 1075.4461452352045, 12681.619551413289, 13411.597652070453, 13461.798073028913, 13494.392752326168, 13509.324533773271, 220008.0, 223736.0, 225147.0, 226383.0, 226470.0, 45340.09319813585, 45965.77017114893, 46005.7699711506, 46018.30972535415, 46116.7694161527, 1270.3775150176348, 1285.8135570342436, 1291.8837304642627, 1300.4213125159213, 1307.9607611771662, 24985.625215622145, 26395.736042639328, 26398.20805375842, 26928.192154235403, 27092.593611095454, 38694.80652596719, 39525.2094958105, 39567.2086558273, 39757.80121099376, 39932.20135597214, 251652.0, 252324.0, 252335.0, 253218.0, 254572.0, 23013.65479517775, 24068.39829004289, 24241.51516969686, 24285.878570607034, 24311.149109781072, 35260.64739352574, 37215.62784372122, 37744.433833491974, 38329.4250586247, 38572.2285554293, 30226.395472090873, 30718.078457646305, 30856.845715771276, 30920.536191957588, 31043.223919402197, 31651.683483164874, 33023.834880825445, 33186.33627327488, 33304.1673958153, 33377.33245335031, 26890.32774180661, 30774.538381924736, 31350.68649313569, 33100.503492448115, 33419.0, 28019.719802801712, 29069.0, 30723.231919201306, 31000.379992399576, 31102.68897310998, 23210.88394558084, 23626.0, 23901.521969560858, 23944.161954331514, 23947.004251449536], "value": 15198.146741075601, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.24331580155484, 388.69487452349904, 390.95113110861126, 393.3568615313961, 409.9467069280993, 14618.195999220052, 15782.289796959136, 15805.84194158058, 15853.0, 15982.12098334591, 15148.242587870618, 15503.379864805422, 16402.425915092976, 16406.26171822268, 16430.342786288566, 4545.863624091283, 5088.313077734496, 5092.9745351273195, 5097.464766199551, 5113.667611605252, 3662.761920475174, 5448.645838020516, 5773.134029895507, 5819.418058194189, 5843.18195452637, 5425.755840987145, 5718.456746609087, 5759.913601295984, 5769.596128271022, 5777.306723193223, 5731.799387021455, 5737.3975732548315, 5745.253117094772, 5750.137479378085, 5765.740541675635, 4862.902741945141, 4944.703317800908, 4961.5286547777905, 4973.4280557735965, 5120.487951204887, 19315.0, 19369.12838922252, 19434.514137146685, 19591.80408195914, 19596.902015489974, 1836.1920754867815, 1892.8864268143955, 1937.0411646235063, 2014.74815648044, 2393.994522300638, 12191.39043047853, 12898.80651790224, 13019.479220831156, 13139.605811825564, 13144.802827957492, 1665.6585399993094, 1746.6594014167242, 1758.4636685810822, 1771.052486919492, 1823.6535058339007, 54515.45484545144, 57081.714591426775, 57300.140497892564, 57411.13883291754, 57897.42102579005, 9154.542272886329, 9185.63257469707, 9224.446533208029, 9231.169194772503, 9258.351915365995, 12552.058595605184, 12604.49582016709, 12656.557020504239, 12665.430055647334, 12693.111482196342, 7393.741219057307, 7422.814429639302, 7506.061742282215, 7586.279303466162, 7588.658510367047, 7234.782956511313, 7302.342789149002, 7316.609844129598, 7364.153122390993, 7415.85168296631, 5974.492168165754, 6041.2750469943885, 6044.455998960115, 6044.879102417927, 6060.727267272983, 1666.9749953750704, 1752.3954235788633, 1861.8324350808493, 1884.5948121154017, 1900.4678689966831, 849.8810166576684, 936.194872409727, 941.3363578677153, 982.4498280962683, 995.4226548601794, 14986.925065374604, 15075.0, 15172.317245723969, 15302.311395987208, 16513.6697266054, 872.829798189347, 920.4891285336569, 939.9953000234955, 944.8582712593029, 975.5366201054584, 9420.90579094214, 9467.573959171854, 9539.14147726708, 9563.139317461322, 9734.41593504392, 347757.0, 348696.0, 348883.0, 358650.0, 388598.0, 54321.45678543243, 60300.39699603036, 62249.0, 63347.6832615834, 63461.0, 910.2308549275851, 930.02812061396, 938.1650331205233, 974.3033730882453, 976.9413835169912, 14078.155310681392, 14135.505257315945, 14186.219757913414, 14492.058016228912, 14578.343974521384, 28541.28646783847, 32289.192770180933, 32504.512432313062, 33375.33249334951, 33748.66251337554, 36115.458268126524, 37337.0, 38816.0, 39439.408408874464, 40943.976400590225, 6870.553414028072, 7138.357547820721, 7159.319864612853, 7220.638968051471, 7494.138174110047, 10968.287061340987, 10972.725681858017, 11001.394923279297, 11248.606298779503, 11261.66215013551, 9736.41581505112, 9852.113309801865, 9910.603575857174, 9992.900070999198, 10109.848352274576, 9805.2646051545, 9957.302988790716, 10065.194784417376, 10173.23700722434, 10227.43749093807, 9345.48599827016, 9974.40153590787, 10117.0, 10123.898761012295, 10166.593336266467, 7357.5217610855125, 7629.504082234637, 7641.88537171954, 7719.0, 7831.2560306770765, 9257.629694812402, 9791.902080979098, 9953.950230248802, 10090.54592543352, 10094.507943964865], "value": 8054.793686849156, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.4314245872881, 1473.557932620214, 1609.6217388913603, 1736.800267969184, 1788.3651303787155, 6610.570312929668, 7333.413326933845, 7412.888806667905, 7702.9614851925735, 7727.034120734915, 7363.300486453792, 7454.993575867256, 7463.738769143081, 7474.103107627078, 7475.140358858733, 2168.2736283345057, 2188.1903695632636, 2189.8576592521513, 2202.130158587357, 2205.974221986776, 2189.0805861538192, 2206.5145667953025, 2266.660000999847, 2269.092363054783, 2270.239469777618, 2235.5417139486367, 2254.0983606557343, 2260.446190683285, 2274.2722328854775, 2277.1802151225547, 2204.691343211952, 2210.3037543173928, 2212.9225477108384, 2215.4572129828134, 2216.312942987671, 2083.468715477559, 2099.391176558796, 2100.0864623888656, 2100.8949552522467, 2103.1272022110957, 7658.693652253904, 7672.3478504327195, 7700.306972372513, 7718.729844455417, 7735.110462296851, 4636.443626764776, 4767.189577771787, 4789.616830653539, 4805.951940480585, 4812.302216178635, 2976.523756198998, 3064.9693503064905, 3090.6909309069138, 3094.3965926644314, 3101.6743241959493, 914.8216097860919, 943.9103285187896, 949.7815502434479, 966.5650457294246, 966.8308046091905, 10091.69724908254, 10143.188544916462, 10155.79688406235, 10158.0, 10167.796644067077, 4290.2706539888295, 4292.506361768436, 4363.36731173978, 4384.276594361958, 4386.122775444924, 8864.64541418349, 8871.423357481743, 8888.955555222183, 8898.73303800887, 8906.02033776284, 4758.547937945889, 4783.612752301793, 4802.159622066124, 4802.975985120052, 4814.181589129857, 3757.1734218471893, 4241.215375155544, 4316.848910288125, 4334.761588112621, 4347.586979236968, 3500.4049311617086, 3556.626554211822, 3558.5907620623443, 3626.1478552540134, 3648.7445878788762, 1226.4971361741643, 1240.1938739819009, 1249.6563445052684, 1257.415301884628, 1263.065331654569, 772.9652165652559, 908.5911339896941, 913.9543022848964, 918.4168053286211, 942.4769253064478, 5346.385165705994, 5407.215953686693, 5419.539339156216, 5478.287822583118, 5638.2670252866865, 427.55107137505496, 430.9892252693645, 433.18128736687686, 436.4653299707833, 440.9691321607457, 3834.386498160337, 3866.4586957825927, 3885.8639947602264, 3910.178862438863, 3958.267720471722, 8878.422902511316, 9145.0, 9146.496942668084, 9199.402038867453, 9222.631094756269, 8817.07420720815, 8848.159424854628, 8991.325650576233, 9012.63949442028, 9059.320550958704, 6998.860022799618, 7013.193482749549, 7055.294470553006, 7071.116110486189, 7086.433085353159, 5130.179171332569, 5220.738963051908, 5231.764570594256, 5304.443033481429, 5448.972755136199, 8312.501249925024, 8342.416030877781, 8535.146485351415, 8674.002489713512, 8693.04376518595, 8275.875861862198, 8605.483670979762, 8612.009618893657, 8652.048274689905, 8866.77833054153, 6062.909056364247, 6387.105805187371, 6437.452816510649, 6572.112764776694, 6582.76960306387, 7120.786376408716, 7144.142702875688, 7199.676014579251, 7212.4230061596, 7213.855722885408, 6320.62076275425, 6547.181602299713, 6622.933770662232, 6624.238212605612, 6661.034150048313, 6372.330905255067, 6413.390727880844, 6423.229212494531, 6430.5177111715875, 6448.516361272829, 6270.216222972129, 6366.204224471941, 6366.363363663597, 6385.8722825544155, 6388.552801303864, 4477.0, 4664.160451118695, 4664.416947881515, 4674.76626168697, 4676.064787042673, 4240.300350442266, 4315.136972605429, 4344.391785150145, 4384.627306678968, 4385.473743150842], "value": 4054.2629496204186, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.1760168337912, 303.2963524622874, 310.4133188274161, 310.55590505577015, 312.3097953522715, 4821.734804585746, 4878.829240976566, 4912.2386030165335, 4921.950780492194, 4923.483034281403, 4850.757462126897, 4894.97552512237, 4900.436449808273, 4909.116359055369, 4910.508949105088, 3639.3813051781194, 3717.5353080864893, 3861.9613803861885, 3868.651821336079, 3872.9736619795776, 3856.8842934712, 3879.1078052048047, 3883.592222816606, 3897.2010737798682, 3901.2977664020605, 3873.205992771489, 3876.282887665777, 3881.8835434936855, 3882.611738826123, 3896.7272290939645, 3782.602826703184, 3811.8284677189595, 3862.208247309295, 3864.787436690981, 3868.3810590305416, 3368.9157771055675, 3387.305602351512, 3397.3205358928312, 3397.473391624302, 3402.081438011723, 4725.173094708447, 4725.5510726480925, 4726.7400292983875, 4774.880627984294, 4779.593734532569, 4345.369921361416, 4347.413099231627, 4360.934585981213, 4361.825526978917, 4362.978185109086, 4913.557779799835, 5105.897882042338, 5132.743362831843, 5143.408508021551, 5157.638965272433, 3658.5975542690285, 3687.9262414751825, 3695.9630403695887, 3700.093477098128, 3703.6111208323277, 5326.387465441485, 5360.705161216131, 5428.864278393033, 5454.59090568205, 5456.290682211326, 3659.2315613721416, 3739.2895349883433, 3788.6590206881515, 3806.5241844769403, 3828.2534905693124, 3826.1199924017073, 3843.5010345965097, 3852.9807350963065, 3858.4212368145004, 3864.9227015459533, 4366.716163449366, 4392.2094023075515, 4399.23013472641, 4401.119776044804, 4404.273294906368, 5024.346834911438, 5096.413912400048, 5128.282040514331, 5165.9225111623355, 5175.870603234949, 1412.569166404236, 1419.3116338575783, 1421.623269833495, 1424.2451500704642, 1425.0, 888.5424006636588, 944.593824655391, 966.8453047512364, 971.5482300730054, 983.5672304186278, 4470.374147619336, 4612.492625811158, 4644.651651126179, 4655.114678555191, 4664.183767840615, 5292.576593872558, 5308.548773354308, 5334.359876814807, 5347.0, 5351.732413379315, 4459.420275364182, 4600.205919691323, 4633.189191891405, 4635.374224479652, 4651.023285110165, 2994.6705862355125, 3015.62304711911, 3048.6189226346705, 3057.1592811976884, 3060.2502386914903, 5390.676559406448, 5416.295881535375, 5424.752306969419, 5430.239766432703, 5437.782488700487, 5168.767405466763, 5479.808206712825, 5508.779648814083, 5790.478856902899, 5809.622374545641, 5091.439941606494, 5109.489051094861, 5111.233315002705, 5123.7199446246805, 5163.483651634807, 5355.9464405357, 5388.272583201375, 5396.487333703292, 5402.27069345649, 5418.241446197457, 5119.872003199801, 5260.158374660036, 5267.499587539178, 5293.497117773805, 5310.256564080954, 5118.97440512795, 5135.0, 5146.408163061295, 5148.90661923764, 5161.793528258828, 3660.6339366064244, 3742.569604495518, 3743.2139250757646, 3747.3254814133716, 3767.7174211933666, 5124.410692770379, 5387.946120538744, 5425.701586412785, 5440.782368705366, 5447.412479072409, 5205.921911171411, 5207.6875387476875, 5238.68567885928, 5253.058287359091, 5261.631685781958, 5144.588432925282, 5204.297419848272, 5221.477852214748, 5242.659227150223, 5259.447757985509, 5034.4462109167225, 5118.8720281991755, 5158.690478571298, 5159.896802064013, 5162.148245539444, 4938.802447902188, 5021.774020169174, 5145.382554093533, 5230.738463076755, 5256.39551451588, 5009.0983622948215, 5058.974705126451, 5069.138246498031, 5071.695698257969, 5094.2867998479505], "value": 3943.3969365263724, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.5525883932568, 757.4470636435402, 770.2220757035393, 774.5546310871247, 785.7839094249077, 12311.569095081673, 12454.564090256843, 12486.0, 12489.500419983202, 12535.0, 10726.410047447387, 10789.19081068919, 10800.459977001157, 10801.56793728252, 10845.83731244032, 631.0471188505344, 772.2856357868949, 792.3225642076014, 817.4155478832633, 817.9918200818005, 802.1016461563029, 803.6945960534988, 809.8663720486113, 810.1250649298743, 811.1969150540981, 852.0244320253306, 859.0764927702713, 859.5745106172453, 859.9011113721939, 861.0098386855104, 844.5481667307992, 845.8984921809422, 847.4322204123191, 850.0946491986015, 852.045708806138, 618.2766163588612, 620.2092332276338, 623.6850390552787, 624.0202881476084, 624.5565648389603, 12657.683557911127, 12687.175333603287, 12705.364731763468, 12709.300988445631, 12762.0, 12497.687557811036, 12706.745865082647, 12707.93646031764, 12792.61622151337, 12946.287954162517, 9382.812343753087, 9601.951990240004, 9766.414015159113, 9826.557804898797, 9940.90059099407, 4171.561985991488, 4181.205570941512, 4221.894452638709, 4229.49246090468, 4231.0, 45173.77413112913, 46659.60230636413, 46680.299795503095, 47082.0, 47151.5284847154, 9671.564779584936, 9722.659706910224, 9814.607415703293, 9847.261455390875, 10035.79928401428, 16961.406350777663, 16986.065766382966, 17000.319987200375, 17039.829601703823, 17096.48710538686, 6917.550359226634, 6937.3062693731235, 6987.685554150075, 7038.40173585251, 7099.112610923635, 3640.21735326906, 3744.120131769032, 3784.413415920537, 3802.391617341212, 3818.503594532693, 2820.605115283862, 2850.458412901542, 2872.052222766482, 2876.5685147228082, 2879.337752316979, 524.4100387064552, 532.97068661224, 533.4185737546015, 534.9408171819819, 536.8443151486103, 541.3990470577655, 556.3629644057531, 609.6464050850497, 627.8949049672518, 664.2129077043719, 8297.8340433191, 8417.368697347723, 8503.207910517825, 8578.142185781497, 8717.694880679273, 542.9864253393697, 550.0209626864188, 610.4201009041428, 619.2383368456823, 637.2034956304619, 3843.442700808367, 3902.804859757001, 3963.8612648557164, 4002.399640053957, 4071.75569465833, 52155.21767173419, 54767.72616136894, 54969.0, 55187.724061379435, 55246.17130743042, 47685.04629907382, 48122.5187748125, 48215.0, 48509.5149048505, 49255.0, 44735.55264447314, 44875.77562112234, 45084.54915450804, 45200.77399612981, 45671.77164114158, 7344.742933997284, 7919.524828510308, 8577.82844343122, 8708.433951793113, 8761.342899282452, 29434.85282573659, 30376.696233037386, 30459.69540304657, 30976.60605272723, 31459.213519662193, 40962.590374095875, 42131.0, 42132.57867421286, 42266.788666056476, 42470.0, 10770.892291077302, 10879.456027198767, 10937.398443085707, 11320.773584528428, 11593.536258549564, 11902.226355286879, 11936.224145430519, 11955.64133076009, 12063.21589096706, 12317.568885089337, 11125.499352529318, 11129.83305250438, 11180.161487888277, 11570.710732231762, 12236.510539578318, 11302.886971130183, 11542.249753765978, 11824.172307938361, 11831.645050648494, 12135.575254866037, 11095.611653592085, 11467.369294688539, 11498.25261358009, 11541.82687259675, 11639.0, 9319.301052421231, 9339.673111441067, 9557.713268601952, 9893.0, 10163.898361016296, 9470.715878523655, 9548.37935534188, 10244.282900196915, 10264.794704106025, 10266.435346056038], "value": 6086.655858932787, "unit": "score"}], "name": "dromaeo_css", "value": 6195.134825477345, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 112.0, 113.0, 114.0, 126.0, 111.0, 113.0, 112.0, 112.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 131.0, 158.0, 191.0, 139.0, 169.0, 167.0, 135.0, 202.0, 130.0], "value": 158.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 177.0, 163.0, 163.0, 164.0, 163.0, 170.0, 162.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 77.0, 160.0, 76.0, 77.0, 77.0, 74.0, 163.0, 75.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 146.0, 98.0, 95.0, 95.0, 142.0, 94.0, 94.0, 142.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 118.0, 120.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 149.0, 147.0, 147.0, 147.0, 146.0, 148.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 97.0, 96.0, 95.0, 95.0, 97.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 64.0, 67.0, 67.0, 82.0, 64.0, 63.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 67.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 78.0, 79.0, 82.0, 79.0, 81.0, 80.0, 90.0, 83.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 135.0, 144.0, 138.0, 134.0, 143.0, 133.0, 131.0, 166.0, 136.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [223.0, 214.0, 217.0, 221.0, 215.0, 215.0, 216.0, 215.0, 218.0, 215.0], "value": 216.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 74.0, 74.0, 75.0, 76.0, 73.0, 74.0, 74.0, 76.0], "value": 74.8, "unit": "score"}], "name": "kraken", "value": 1646.2, "alertThreshold": 2.0}]} 01:45:30 INFO - Return code: 0 01:45:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:45:30 ERROR - # TBPL SUCCESS # 01:45:30 INFO - Running post-action listener: _resource_record_post_action 01:45:30 INFO - Running post-run listener: _resource_record_post_run 01:45:31 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 468692992; Read time: 12; Write time: 272508 01:45:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 172007424; Read time: 0; Write time: 133812 01:45:31 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296685568; Read time: 12; Write time: 138696 01:45:31 INFO - Running post-run listener: _upload_blobber_files 01:45:31 INFO - Blob upload gear active. 01:45:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:45:31 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 01:45:31 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'] 01:45:31 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 01:45:32 INFO - (blobuploader) - INFO - Open directory for files ... 01:45:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:45:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:45:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:33 INFO - (blobuploader) - INFO - Done attempting. 01:45:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:45:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:45:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:33 INFO - (blobuploader) - INFO - Done attempting. 01:45:33 INFO - (blobuploader) - INFO - Iteration through files over. 01:45:33 INFO - Return code: 0 01:45:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:45:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:45:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4ee66bb266db1e5adb2e0f8d499a0be055f7fb0bd11e4ac0b8a0a64e602405a4462b2ba0dcfc7b57eaf05ae66fc43df2a984e12231be495d29ed6b16bca5a8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c508b5fadbeefe1c025d4943d555f7ca4b77033095b72b37456c924d0a56d1f0be1b96df3634fea5fcdaea652d92439eb430f70c96f456dc2a5683cbc00364c7"} 01:45:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:45:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:45:33 INFO - Contents: 01:45:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4ee66bb266db1e5adb2e0f8d499a0be055f7fb0bd11e4ac0b8a0a64e602405a4462b2ba0dcfc7b57eaf05ae66fc43df2a984e12231be495d29ed6b16bca5a8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c508b5fadbeefe1c025d4943d555f7ca4b77033095b72b37456c924d0a56d1f0be1b96df3634fea5fcdaea652d92439eb430f70c96f456dc2a5683cbc00364c7"} 01:45:33 INFO - Running post-run listener: copy_logs_to_upload_dir 01:45:33 INFO - Copying logs to upload dir... 01:45:33 INFO - mkdir: /builds/slave/test/build/upload/logs 01:45:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.202439 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-28 01:45:33.737190) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 01:45:33.740478) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4ee66bb266db1e5adb2e0f8d499a0be055f7fb0bd11e4ac0b8a0a64e602405a4462b2ba0dcfc7b57eaf05ae66fc43df2a984e12231be495d29ed6b16bca5a8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c508b5fadbeefe1c025d4943d555f7ca4b77033095b72b37456c924d0a56d1f0be1b96df3634fea5fcdaea652d92439eb430f70c96f456dc2a5683cbc00364c7"} build_url:https://queue.taskcluster.net/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011342 build_url: 'https://queue.taskcluster.net/v1/task/ABPnl1ZkTVKuh1e-hvUvow/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4ee66bb266db1e5adb2e0f8d499a0be055f7fb0bd11e4ac0b8a0a64e602405a4462b2ba0dcfc7b57eaf05ae66fc43df2a984e12231be495d29ed6b16bca5a8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c508b5fadbeefe1c025d4943d555f7ca4b77033095b72b37456c924d0a56d1f0be1b96df3634fea5fcdaea652d92439eb430f70c96f456dc2a5683cbc00364c7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 01:45:33.769329) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:45:33.769800) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461831522.191545-572050778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:45:33.849469) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 01:45:33.849838) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 01:45:33.850232) ========= ========= Total master_lag: 0.31 =========