builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1462544881.52 results: success (0) buildid: 20160506064620 builduid: 48973e8eecc94d9989c2a1ec7b465d6d revision: f97139bf14beb480b3255c69b3e43f376c548e31 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.520115) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.520599) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.520923) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.545324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.545694) ========= 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=ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 07:28:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 223M=0s 2016-05-06 07:28:01 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070542 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.629893) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.630253) ========= 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=ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016478 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.681629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:01.682047) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f97139bf14beb480b3255c69b3e43f376c548e31 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f97139bf14beb480b3255c69b3e43f376c548e31 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 07:28:01,813 truncating revision to first 12 chars 2016-05-06 07:28:01,814 Setting DEBUG logging. 2016-05-06 07:28:01,814 attempt 1/10 2016-05-06 07:28:01,814 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f97139bf14be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 07:28:02,063 unpacking tar archive at: fx-team-f97139bf14be/testing/mozharness/ program finished with exit code 0 elapsedTime=0.522156 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:02.217466) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:02.217804) ========= script_repo_revision: f97139bf14beb480b3255c69b3e43f376c548e31 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:02.218246) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:02.218582) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 07:28:02.233138) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-06 07:28:02.233546) ========= /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=ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:28:02 INFO - MultiFileLogger online at 20160506 07:28:02 in /builds/slave/test 07:28:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-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 07:28:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:28:02 INFO - {'append_to_log': False, 07:28:02 INFO - 'base_work_dir': '/builds/slave/test', 07:28:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:28:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:28:02 INFO - 'branch': 'Fx-Team-Non-PGO', 07:28:02 INFO - 'buildbot_json_path': 'buildprops.json', 07:28:02 INFO - 'config_files': ('talos/linux_config.py',), 07:28:02 INFO - 'default_actions': ('clobber', 07:28:02 INFO - 'read-buildbot-config', 07:28:02 INFO - 'download-and-extract', 07:28:02 INFO - 'populate-webroot', 07:28:02 INFO - 'create-virtualenv', 07:28:02 INFO - 'install', 07:28:02 INFO - 'run-tests'), 07:28:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:28:02 INFO - 'download_minidump_stackwalk': True, 07:28:02 INFO - 'download_symbols': 'ondemand', 07:28:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:28:02 INFO - 'tooltool.py': '/tools/tooltool.py', 07:28:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:28:02 INFO - '/tools/misc-python/virtualenv.py')}, 07:28:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:28:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:28:02 INFO - 'installer_path': 'installer.exe', 07:28:02 INFO - 'log_level': 'info', 07:28:02 INFO - 'log_name': 'talos', 07:28:02 INFO - 'log_to_console': True, 07:28:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:28:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:28:02 INFO - 'opt_config_files': (), 07:28:02 INFO - 'pip_index': False, 07:28:02 INFO - 'sps_profile': False, 07:28:02 INFO - 'sps_profile_interval': 0, 07:28:02 INFO - 'suite': 'dromaeojs-e10s', 07:28:02 INFO - 'system_bits': '32', 07:28:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:28:02 INFO - 'title': 'talos-linux64-ix-035', 07:28:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:28:02 INFO - 'use_talos_json': True, 07:28:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:28:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:28:02 INFO - 'work_dir': 'build'} 07:28:02 INFO - ##### 07:28:02 INFO - ##### Running clobber step. 07:28:02 INFO - ##### 07:28:02 INFO - Running pre-action listener: _resource_record_pre_action 07:28:02 INFO - Running main action method: clobber 07:28:02 INFO - rmtree: /builds/slave/test/build 07:28:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:28:02 INFO - Running post-action listener: _resource_record_post_action 07:28:02 INFO - ##### 07:28:02 INFO - ##### Finished clobber step (success) 07:28:02 INFO - ##### 07:28:02 INFO - ##### 07:28:02 INFO - ##### Running read-buildbot-config step. 07:28:02 INFO - ##### 07:28:02 INFO - Running pre-action listener: _resource_record_pre_action 07:28:02 INFO - Running main action method: read_buildbot_config 07:28:02 INFO - Using buildbot properties: 07:28:02 INFO - { 07:28:02 INFO - "project": "", 07:28:02 INFO - "product": "firefox", 07:28:02 INFO - "script_repo_revision": "production", 07:28:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:28:02 INFO - "repository": "", 07:28:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:28:02 INFO - "buildid": "20160506064620", 07:28:02 INFO - "pgo_build": "False", 07:28:02 INFO - "basedir": "/builds/slave/test", 07:28:02 INFO - "buildnumber": 1245, 07:28:02 INFO - "slavename": "talos-linux64-ix-035", 07:28:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:28:02 INFO - "platform": "ubuntu64_hw", 07:28:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:28:02 INFO - "branch": "fx-team", 07:28:02 INFO - "repo_path": "integration/fx-team", 07:28:02 INFO - "revision": "f97139bf14beb480b3255c69b3e43f376c548e31", 07:28:02 INFO - "stage_platform": "linux64", 07:28:02 INFO - "builduid": "48973e8eecc94d9989c2a1ec7b465d6d", 07:28:02 INFO - "slavebuilddir": "test" 07:28:02 INFO - } 07:28:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:28:02 INFO - Running post-action listener: _resource_record_post_action 07:28:02 INFO - ##### 07:28:02 INFO - ##### Finished read-buildbot-config step (success) 07:28:02 INFO - ##### 07:28:02 INFO - ##### 07:28:02 INFO - ##### Running download-and-extract step. 07:28:02 INFO - ##### 07:28:02 INFO - Running pre-action listener: _resource_record_pre_action 07:28:02 INFO - Running main action method: download_and_extract 07:28:02 INFO - mkdir: /builds/slave/test/build/tests 07:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:02 INFO - https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:28:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:28:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:28:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:28:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:28:09 INFO - Downloaded 1361 bytes. 07:28:09 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:28:09 INFO - Using the following test package requirements: 07:28:09 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:09 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:28:09 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:28:09 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:09 INFO - u'jsshell-linux-x86_64.zip'], 07:28:09 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:28:09 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:09 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:28:09 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:28:09 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:28:09 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:28:09 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:09 INFO - https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:28:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:28:14 INFO - Downloaded 22321395 bytes. 07:28:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:28:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:28:15 INFO - Return code: 0 07:28:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:15 INFO - https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:28:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:28:16 INFO - Downloaded 22321395 bytes. 07:28:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:28:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:28:17 INFO - Return code: 0 07:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:17 INFO - https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:28:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:28:18 INFO - Downloaded 10840152 bytes. 07:28:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:28:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:28:19 INFO - Return code: 0 07:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:19 INFO - https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:28:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:28:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:28:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:28:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:28:20 INFO - Downloaded 54839136 bytes. 07:28:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:28:20 INFO - mkdir: /builds/slave/test/properties 07:28:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:28:20 INFO - Writing to file /builds/slave/test/properties/build_url 07:28:20 INFO - Contents: 07:28:20 INFO - build_url:https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:28:21 INFO - Running post-action listener: _resource_record_post_action 07:28:21 INFO - Running post-action listener: set_extra_try_arguments 07:28:21 INFO - ##### 07:28:21 INFO - ##### Finished download-and-extract step (success) 07:28:21 INFO - ##### 07:28:21 INFO - ##### 07:28:21 INFO - ##### Running populate-webroot step. 07:28:21 INFO - ##### 07:28:21 INFO - Running pre-action listener: _resource_record_pre_action 07:28:21 INFO - Running main action method: populate_webroot 07:28:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:28:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:28:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:28:21 INFO - '--tppagecycles', 07:28:21 INFO - '7'], 07:28:21 INFO - 'tests': ['tsvgm']}}, 07:28:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:28:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:28:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:28:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:28:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:28:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:28:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:21 INFO - 'talos_options': ['--disable-e10s'], 07:28:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:28:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:28:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:21 INFO - 'talos_options': ['--disable-e10s'], 07:28:21 INFO - 'tests': ['damp', 'tps']}, 07:28:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:21 INFO - 'tests': ['damp', 'tps']}, 07:28:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:28:21 INFO - 'tests': ['dromaeo_dom']}, 07:28:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:28:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:28:21 INFO - 'tests': ['a11yr', 07:28:21 INFO - 'ts_paint', 07:28:21 INFO - 'tpaint', 07:28:21 INFO - 'sessionrestore', 07:28:21 INFO - 'sessionrestore_no_auto_restore', 07:28:21 INFO - 'tabpaint']}, 07:28:21 INFO - 'other-e10s': {'tests': ['a11yr', 07:28:21 INFO - 'ts_paint', 07:28:21 INFO - 'tpaint', 07:28:21 INFO - 'sessionrestore', 07:28:21 INFO - 'sessionrestore_no_auto_restore', 07:28:21 INFO - 'tabpaint']}, 07:28:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:28:21 INFO - 'ts_paint', 07:28:21 INFO - 'tpaint', 07:28:21 INFO - 'sessionrestore', 07:28:21 INFO - 'sessionrestore_no_auto_restore', 07:28:21 INFO - 'tabpaint']}, 07:28:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:28:21 INFO - 'ts_paint', 07:28:21 INFO - 'tpaint', 07:28:21 INFO - 'sessionrestore', 07:28:21 INFO - 'sessionrestore_no_auto_restore', 07:28:21 INFO - 'tabpaint']}, 07:28:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:28:21 INFO - 'tests': ['a11yr', 07:28:21 INFO - 'ts_paint', 07:28:21 INFO - 'tpaint', 07:28:21 INFO - 'sessionrestore', 07:28:21 INFO - 'sessionrestore_no_auto_restore', 07:28:21 INFO - 'tabpaint']}, 07:28:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:28:21 INFO - 'tests': ['a11yr', 07:28:21 INFO - 'ts_paint', 07:28:21 INFO - 'tpaint', 07:28:21 INFO - 'sessionrestore', 07:28:21 INFO - 'sessionrestore_no_auto_restore', 07:28:21 INFO - 'tabpaint']}, 07:28:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:28:21 INFO - 'tests': ['tsvgx', 07:28:21 INFO - 'tsvgr_opacity', 07:28:21 INFO - 'tart', 07:28:21 INFO - 'tscrollx', 07:28:21 INFO - 'cart']}, 07:28:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:28:21 INFO - 'tsvgr_opacity', 07:28:21 INFO - 'tart', 07:28:21 INFO - 'tscrollx', 07:28:21 INFO - 'cart']}, 07:28:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:21 INFO - 'talos_options': ['--disable-e10s'], 07:28:21 INFO - 'tests': ['tp5o']}, 07:28:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:21 INFO - 'tests': ['tp5o']}, 07:28:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:21 INFO - 'talos_options': ['--disable-e10s', 07:28:21 INFO - '--xperf_path', 07:28:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:28:21 INFO - 'tests': ['tp5n']}, 07:28:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:21 INFO - 'talos_options': ['--xperf_path', 07:28:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:28:21 INFO - 'tests': ['tp5n']}}, 07:28:21 INFO - 'talos.zip': {'path': '', 07:28:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:28:21 INFO - Running post-action listener: _resource_record_post_action 07:28:21 INFO - ##### 07:28:21 INFO - ##### Finished populate-webroot step (success) 07:28:21 INFO - ##### 07:28:21 INFO - ##### 07:28:21 INFO - ##### Running create-virtualenv step. 07:28:21 INFO - ##### 07:28:21 INFO - Running pre-action listener: _resource_record_pre_action 07:28:21 INFO - Running main action method: create_virtualenv 07:28:21 INFO - Creating virtualenv /builds/slave/test/build/venv 07:28:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:28:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:28:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:28:21 INFO - Using real prefix '/usr' 07:28:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:28:22 INFO - Installing distribute.............................................................................................................................................................................................done. 07:28:24 INFO - Installing pip.................done. 07:28:24 INFO - Return code: 0 07:28:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:24 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 0x7f94c6c6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2366410>, '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 0x2367310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23677a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:28:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:28:24 INFO - Using env: {'DISPLAY': ':0', 07:28:24 INFO - 'HOME': '/home/cltbld', 07:28:24 INFO - 'LANG': 'en_US.UTF-8', 07:28:24 INFO - 'LANGUAGE': 'en_US:en', 07:28:24 INFO - 'LOGNAME': 'cltbld', 07:28:24 INFO - 'MAIL': '/var/mail/cltbld', 07:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:24 INFO - 'MOZ_NO_REMOTE': '1', 07:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:24 INFO - 'NO_EM_RESTART': '1', 07:28:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:24 INFO - 'PWD': '/builds/slave/test', 07:28:24 INFO - 'SHELL': '/bin/bash', 07:28:24 INFO - 'SHLVL': '1', 07:28:24 INFO - 'TERM': 'linux', 07:28:24 INFO - 'TMOUT': '86400', 07:28:24 INFO - 'USER': 'cltbld', 07:28:24 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 07:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:24 INFO - '_': '/tools/buildbot/bin/python'} 07:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:28:24 INFO - Cleaning up... 07:28:24 INFO - Return code: 0 07:28:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:24 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 0x7f94c6c6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2366410>, '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 0x2367310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23677a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:28:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:28:24 INFO - Using env: {'DISPLAY': ':0', 07:28:24 INFO - 'HOME': '/home/cltbld', 07:28:24 INFO - 'LANG': 'en_US.UTF-8', 07:28:24 INFO - 'LANGUAGE': 'en_US:en', 07:28:24 INFO - 'LOGNAME': 'cltbld', 07:28:24 INFO - 'MAIL': '/var/mail/cltbld', 07:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:24 INFO - 'MOZ_NO_REMOTE': '1', 07:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:24 INFO - 'NO_EM_RESTART': '1', 07:28:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:24 INFO - 'PWD': '/builds/slave/test', 07:28:24 INFO - 'SHELL': '/bin/bash', 07:28:24 INFO - 'SHLVL': '1', 07:28:24 INFO - 'TERM': 'linux', 07:28:24 INFO - 'TMOUT': '86400', 07:28:24 INFO - 'USER': 'cltbld', 07:28:24 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 07:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:24 INFO - '_': '/tools/buildbot/bin/python'} 07:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:24 INFO - Downloading/unpacking psutil>=0.7.1 07:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:28:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:26 INFO - Installing collected packages: psutil 07:28:26 INFO - Running setup.py install for psutil 07:28:27 INFO - building 'psutil._psutil_linux' extension 07:28:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:28:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:28:27 INFO - building 'psutil._psutil_posix' extension 07:28:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:28:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:28:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:27 INFO - Successfully installed psutil 07:28:27 INFO - Cleaning up... 07:28:27 INFO - Return code: 0 07:28:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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', '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 0x7f94c6c6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2366410>, '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 0x2367310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23677a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:28: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:28: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 mozsystemmonitor==0.0.0 07:28:27 INFO - Using env: {'DISPLAY': ':0', 07:28:27 INFO - 'HOME': '/home/cltbld', 07:28:27 INFO - 'LANG': 'en_US.UTF-8', 07:28:27 INFO - 'LANGUAGE': 'en_US:en', 07:28:27 INFO - 'LOGNAME': 'cltbld', 07:28:27 INFO - 'MAIL': '/var/mail/cltbld', 07:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:27 INFO - 'MOZ_NO_REMOTE': '1', 07:28:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:27 INFO - 'NO_EM_RESTART': '1', 07:28:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:27 INFO - 'PWD': '/builds/slave/test', 07:28:27 INFO - 'SHELL': '/bin/bash', 07:28:27 INFO - 'SHLVL': '1', 07:28:27 INFO - 'TERM': 'linux', 07:28:27 INFO - 'TMOUT': '86400', 07:28:27 INFO - 'USER': 'cltbld', 07:28:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 07:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:27 INFO - '_': '/tools/buildbot/bin/python'} 07:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:28:30 INFO - Installing collected packages: mozsystemmonitor 07:28:30 INFO - Running setup.py install for mozsystemmonitor 07:28:30 INFO - Successfully installed mozsystemmonitor 07:28:30 INFO - Cleaning up... 07:28:30 INFO - Return code: 0 07:28:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:30 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 0x7f94c6c6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2366410>, '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 0x2367310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23677a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:28:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:28:30 INFO - Using env: {'DISPLAY': ':0', 07:28:30 INFO - 'HOME': '/home/cltbld', 07:28:30 INFO - 'LANG': 'en_US.UTF-8', 07:28:30 INFO - 'LANGUAGE': 'en_US:en', 07:28:30 INFO - 'LOGNAME': 'cltbld', 07:28:30 INFO - 'MAIL': '/var/mail/cltbld', 07:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:30 INFO - 'MOZ_NO_REMOTE': '1', 07:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:30 INFO - 'NO_EM_RESTART': '1', 07:28:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:30 INFO - 'PWD': '/builds/slave/test', 07:28:30 INFO - 'SHELL': '/bin/bash', 07:28:30 INFO - 'SHLVL': '1', 07:28:30 INFO - 'TERM': 'linux', 07:28:30 INFO - 'TMOUT': '86400', 07:28:30 INFO - 'USER': 'cltbld', 07:28:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 07:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:30 INFO - '_': '/tools/buildbot/bin/python'} 07:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:30 INFO - Downloading/unpacking blobuploader==1.2.4 07:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:32 INFO - Downloading blobuploader-1.2.4.tar.gz 07:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:28:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:28:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:33 INFO - Downloading docopt-0.6.1.tar.gz 07:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:28:33 INFO - Installing collected packages: blobuploader, requests, docopt 07:28:33 INFO - Running setup.py install for blobuploader 07:28:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:28:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:28:33 INFO - Running setup.py install for requests 07:28:33 INFO - Running setup.py install for docopt 07:28:33 INFO - Successfully installed blobuploader requests docopt 07:28:33 INFO - Cleaning up... 07:28:33 INFO - Return code: 0 07:28:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:33 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 0x7f94c6c6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2366410>, '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 0x2367310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23677a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:28:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:28:33 INFO - Using env: {'DISPLAY': ':0', 07:28:33 INFO - 'HOME': '/home/cltbld', 07:28:33 INFO - 'LANG': 'en_US.UTF-8', 07:28:33 INFO - 'LANGUAGE': 'en_US:en', 07:28:33 INFO - 'LOGNAME': 'cltbld', 07:28:33 INFO - 'MAIL': '/var/mail/cltbld', 07:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:33 INFO - 'MOZ_NO_REMOTE': '1', 07:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:33 INFO - 'NO_EM_RESTART': '1', 07:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:33 INFO - 'PWD': '/builds/slave/test', 07:28:33 INFO - 'SHELL': '/bin/bash', 07:28:33 INFO - 'SHLVL': '1', 07:28:33 INFO - 'TERM': 'linux', 07:28:33 INFO - 'TMOUT': '86400', 07:28:33 INFO - 'USER': 'cltbld', 07:28:33 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 07:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:33 INFO - '_': '/tools/buildbot/bin/python'} 07:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:34 INFO - Running setup.py (path:/tmp/pip-qKjnu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:34 INFO - Running setup.py (path:/tmp/pip-qVx1UZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:34 INFO - Running setup.py (path:/tmp/pip-SntBGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:34 INFO - Running setup.py (path:/tmp/pip-Ac7OXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:34 INFO - Running setup.py (path:/tmp/pip-YocEoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:34 INFO - Running setup.py (path:/tmp/pip-hFioBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:34 INFO - Running setup.py (path:/tmp/pip-wL9X0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:34 INFO - Running setup.py (path:/tmp/pip-Wk4Vdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:34 INFO - Running setup.py (path:/tmp/pip-GDAQI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:34 INFO - Running setup.py (path:/tmp/pip-eH6GH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:34 INFO - Running setup.py (path:/tmp/pip-JIJ15X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:34 INFO - Running setup.py (path:/tmp/pip-gqn81H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:34 INFO - Running setup.py (path:/tmp/pip-fBoxxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:35 INFO - Running setup.py (path:/tmp/pip-uFgdsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:35 INFO - Running setup.py (path:/tmp/pip-mVX_E6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:35 INFO - Running setup.py (path:/tmp/pip-tkwx_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:35 INFO - Running setup.py (path:/tmp/pip-SCYym3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:28:35 INFO - Running setup.py install for manifestparser 07:28:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:28:35 INFO - Running setup.py install for mozcrash 07:28:35 INFO - Running setup.py install for mozdebug 07:28:35 INFO - Running setup.py install for mozdevice 07:28:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:28:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:28:35 INFO - Running setup.py install for mozfile 07:28:35 INFO - Running setup.py install for mozhttpd 07:28:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:28:35 INFO - Running setup.py install for mozinfo 07:28:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:28:36 INFO - Running setup.py install for mozInstall 07:28:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:28:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:28:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:28:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:28:36 INFO - Running setup.py install for mozleak 07:28:36 INFO - Running setup.py install for mozlog 07:28:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:28:36 INFO - Running setup.py install for moznetwork 07:28:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:28:36 INFO - Running setup.py install for mozprocess 07:28:36 INFO - Running setup.py install for mozprofile 07:28:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:28:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:28:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:28:36 INFO - Running setup.py install for mozrunner 07:28:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:28:36 INFO - Running setup.py install for mozscreenshot 07:28:36 INFO - Running setup.py install for moztest 07:28:36 INFO - Running setup.py install for mozversion 07:28:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:28:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:28:37 INFO - Cleaning up... 07:28:37 INFO - Return code: 0 07:28:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:37 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 0x7f94c6c6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2366410>, '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 0x2367310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23677a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:28:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:28:37 INFO - Using env: {'DISPLAY': ':0', 07:28:37 INFO - 'HOME': '/home/cltbld', 07:28:37 INFO - 'LANG': 'en_US.UTF-8', 07:28:37 INFO - 'LANGUAGE': 'en_US:en', 07:28:37 INFO - 'LOGNAME': 'cltbld', 07:28:37 INFO - 'MAIL': '/var/mail/cltbld', 07:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:37 INFO - 'MOZ_NO_REMOTE': '1', 07:28:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:37 INFO - 'NO_EM_RESTART': '1', 07:28:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:37 INFO - 'PWD': '/builds/slave/test', 07:28:37 INFO - 'SHELL': '/bin/bash', 07:28:37 INFO - 'SHLVL': '1', 07:28:37 INFO - 'TERM': 'linux', 07:28:37 INFO - 'TMOUT': '86400', 07:28:37 INFO - 'USER': 'cltbld', 07:28:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 07:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:37 INFO - '_': '/tools/buildbot/bin/python'} 07:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:37 INFO - Running setup.py (path:/tmp/pip-mXaU2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:37 INFO - Running setup.py (path:/tmp/pip-PhdKWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:37 INFO - Running setup.py (path:/tmp/pip-hWDJ0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:37 INFO - Running setup.py (path:/tmp/pip-6SP0M3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:37 INFO - Running setup.py (path:/tmp/pip-H7ppi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:37 INFO - Running setup.py (path:/tmp/pip-jWAqB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:37 INFO - Running setup.py (path:/tmp/pip-A229Mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:37 INFO - Running setup.py (path:/tmp/pip-r1YFsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:37 INFO - Running setup.py (path:/tmp/pip-jA2x9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:37 INFO - Running setup.py (path:/tmp/pip-H3usYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:38 INFO - Running setup.py (path:/tmp/pip-sp5Fcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:38 INFO - Running setup.py (path:/tmp/pip-gUmGoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:38 INFO - Running setup.py (path:/tmp/pip-e8Z8Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:38 INFO - Running setup.py (path:/tmp/pip-1pY_JG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:38 INFO - Running setup.py (path:/tmp/pip-3KEpsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:38 INFO - Running setup.py (path:/tmp/pip-SvB51o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:38 INFO - Running setup.py (path:/tmp/pip-3XUZqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:28:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:40 INFO - Downloading blessings-1.6.tar.gz 07:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:28:40 INFO - Installing collected packages: blessings 07:28:40 INFO - Running setup.py install for blessings 07:28:40 INFO - Successfully installed blessings 07:28:40 INFO - Cleaning up... 07:28:40 INFO - Return code: 0 07:28:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:28:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:40 INFO - Reading from file tmpfile_stdout 07:28:40 INFO - Current package versions: 07:28:40 INFO - argparse == 1.2.1 07:28:40 INFO - blessings == 1.6 07:28:40 INFO - blobuploader == 1.2.4 07:28:40 INFO - docopt == 0.6.1 07:28:40 INFO - manifestparser == 1.1 07:28:40 INFO - mozInstall == 1.12 07:28:40 INFO - mozcrash == 0.17 07:28:40 INFO - mozdebug == 0.1 07:28:40 INFO - mozdevice == 0.48 07:28:40 INFO - mozfile == 1.2 07:28:40 INFO - mozhttpd == 0.7 07:28:40 INFO - mozinfo == 0.9 07:28:40 INFO - mozleak == 0.1 07:28:40 INFO - mozlog == 3.1 07:28:40 INFO - moznetwork == 0.27 07:28:40 INFO - mozprocess == 0.22 07:28:40 INFO - mozprofile == 0.28 07:28:40 INFO - mozrunner == 6.11 07:28:40 INFO - mozscreenshot == 0.1 07:28:40 INFO - mozsystemmonitor == 0.0 07:28:40 INFO - moztest == 0.7 07:28:40 INFO - mozversion == 1.4 07:28:40 INFO - psutil == 3.1.1 07:28:40 INFO - requests == 1.2.3 07:28:40 INFO - wsgiref == 0.1.2 07:28:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:40 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 0x7f94c6c6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2366410>, '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 0x2367310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23677a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:28:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:28:40 INFO - Using env: {'DISPLAY': ':0', 07:28:40 INFO - 'HOME': '/home/cltbld', 07:28:40 INFO - 'LANG': 'en_US.UTF-8', 07:28:40 INFO - 'LANGUAGE': 'en_US:en', 07:28:40 INFO - 'LOGNAME': 'cltbld', 07:28:40 INFO - 'MAIL': '/var/mail/cltbld', 07:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:40 INFO - 'MOZ_NO_REMOTE': '1', 07:28:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:40 INFO - 'NO_EM_RESTART': '1', 07:28:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:40 INFO - 'PWD': '/builds/slave/test', 07:28:40 INFO - 'SHELL': '/bin/bash', 07:28:40 INFO - 'SHLVL': '1', 07:28:40 INFO - 'TERM': 'linux', 07:28:40 INFO - 'TMOUT': '86400', 07:28:40 INFO - 'USER': 'cltbld', 07:28:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 07:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:40 INFO - '_': '/tools/buildbot/bin/python'} 07:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:28:41 INFO - Cleaning up... 07:28:41 INFO - Return code: 0 07:28:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:41 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 0x7f94c6c6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2366410>, '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 0x2367310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23677a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:28:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:28:41 INFO - Using env: {'DISPLAY': ':0', 07:28:41 INFO - 'HOME': '/home/cltbld', 07:28:41 INFO - 'LANG': 'en_US.UTF-8', 07:28:41 INFO - 'LANGUAGE': 'en_US:en', 07:28:41 INFO - 'LOGNAME': 'cltbld', 07:28:41 INFO - 'MAIL': '/var/mail/cltbld', 07:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:41 INFO - 'MOZ_NO_REMOTE': '1', 07:28:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:41 INFO - 'NO_EM_RESTART': '1', 07:28:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:41 INFO - 'PWD': '/builds/slave/test', 07:28:41 INFO - 'SHELL': '/bin/bash', 07:28:41 INFO - 'SHLVL': '1', 07:28:41 INFO - 'TERM': 'linux', 07:28:41 INFO - 'TMOUT': '86400', 07:28:41 INFO - 'USER': 'cltbld', 07:28:41 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 07:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:41 INFO - '_': '/tools/buildbot/bin/python'} 07:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:41 INFO - Downloading/unpacking jsonschema 07:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:28:43 INFO - Downloading/unpacking functools32 (from jsonschema) 07:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:43 INFO - Downloading functools32-3.2.3-2.tar.gz 07:28:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:28:43 INFO - warning: no files found matching '*.txt' 07:28:43 INFO - no previously-included directories found matching 'build' 07:28:43 INFO - no previously-included directories found matching 'dist' 07:28:43 INFO - no previously-included directories found matching '.git*' 07:28:43 INFO - Installing collected packages: jsonschema, functools32 07:28:43 INFO - Running setup.py install for functools32 07:28:43 INFO - warning: no files found matching '*.txt' 07:28:43 INFO - no previously-included directories found matching 'build' 07:28:43 INFO - no previously-included directories found matching 'dist' 07:28:43 INFO - no previously-included directories found matching '.git*' 07:28:43 INFO - Successfully installed jsonschema functools32 07:28:43 INFO - Cleaning up... 07:28:43 INFO - Return code: 0 07:28:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:43 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 0x7f94c6c6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2366410>, '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 0x2367310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23677a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:28:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:28:43 INFO - Using env: {'DISPLAY': ':0', 07:28:43 INFO - 'HOME': '/home/cltbld', 07:28:43 INFO - 'LANG': 'en_US.UTF-8', 07:28:43 INFO - 'LANGUAGE': 'en_US:en', 07:28:43 INFO - 'LOGNAME': 'cltbld', 07:28:43 INFO - 'MAIL': '/var/mail/cltbld', 07:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:43 INFO - 'MOZ_NO_REMOTE': '1', 07:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:43 INFO - 'NO_EM_RESTART': '1', 07:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:43 INFO - 'PWD': '/builds/slave/test', 07:28:43 INFO - 'SHELL': '/bin/bash', 07:28:43 INFO - 'SHLVL': '1', 07:28:43 INFO - 'TERM': 'linux', 07:28:43 INFO - 'TMOUT': '86400', 07:28:43 INFO - 'USER': 'cltbld', 07:28:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 07:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:43 INFO - '_': '/tools/buildbot/bin/python'} 07:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:43 INFO - Downloading/unpacking flake8 07:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:28:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:28:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:28:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:28:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:28:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:28:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:28:46 INFO - no previously-included directories found matching 'docs/_build' 07:28:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:28:46 INFO - Running setup.py install for pep8 07:28:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:28:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:28:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:28:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:28:46 INFO - no previously-included directories found matching 'docs/_build' 07:28:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:28:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:28:46 INFO - Cleaning up... 07:28:46 INFO - Return code: 0 07:28:46 INFO - Running post-action listener: _resource_record_post_action 07:28:46 INFO - Running post-action listener: _start_resource_monitoring 07:28:46 INFO - Starting resource monitoring. 07:28:46 INFO - ##### 07:28:46 INFO - ##### Finished create-virtualenv step (success) 07:28:46 INFO - ##### 07:28:46 INFO - ##### 07:28:46 INFO - ##### Running install step. 07:28:46 INFO - ##### 07:28:46 INFO - Running pre-action listener: _resource_record_pre_action 07:28:46 INFO - Running main action method: install 07:28:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:46 INFO - Reading from file tmpfile_stdout 07:28:46 INFO - Detecting whether we're running mozinstall >=1.0... 07:28:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:28:46 INFO - Reading from file tmpfile_stdout 07:28:46 INFO - Output received: 07:28:46 INFO - Usage: mozinstall [options] installer 07:28:46 INFO - Options: 07:28:46 INFO - -h, --help show this help message and exit 07:28:46 INFO - -d DEST, --destination=DEST 07:28:46 INFO - Directory to install application into. [default: 07:28:46 INFO - "/builds/slave/test"] 07:28:46 INFO - --app=APP Application being installed. [default: firefox] 07:28:46 INFO - mkdir: /builds/slave/test/build/application 07:28:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:29:02 INFO - Reading from file tmpfile_stdout 07:29:02 INFO - Output received: 07:29:02 INFO - /builds/slave/test/build/application/firefox/firefox 07:29:02 INFO - Running post-action listener: _resource_record_post_action 07:29:02 INFO - ##### 07:29:02 INFO - ##### Finished install step (success) 07:29:02 INFO - ##### 07:29:02 INFO - ##### 07:29:02 INFO - ##### Running run-tests step. 07:29:02 INFO - ##### 07:29:02 INFO - Running pre-action listener: _resource_record_pre_action 07:29:02 INFO - Running main action method: run_tests 07:29:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:29:02 INFO - Python 2.7.3 07:29:02 INFO - Return code: 0 07:29:02 INFO - grabbing minidump binary from tooltool 07:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:02 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 0x2366410>, '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 0x2367310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23677a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:29:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:29:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:29:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:29:02 INFO - Return code: 0 07:29:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:29:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:29:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:29:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:29:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:29:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:29:03 INFO - Return code: 0 07:29:03 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/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 07:29:03 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/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 07:29:03 INFO - Using env: {'DISPLAY': ':0', 07:29:03 INFO - 'HOME': '/home/cltbld', 07:29:03 INFO - 'LANG': 'en_US.UTF-8', 07:29:03 INFO - 'LANGUAGE': 'en_US:en', 07:29:03 INFO - 'LOGNAME': 'cltbld', 07:29:03 INFO - 'MAIL': '/var/mail/cltbld', 07:29:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:29:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:03 INFO - 'MOZ_NO_REMOTE': '1', 07:29:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:03 INFO - 'NO_EM_RESTART': '1', 07:29:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:03 INFO - 'PWD': '/builds/slave/test', 07:29:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:29:03 INFO - 'SHELL': '/bin/bash', 07:29:03 INFO - 'SHLVL': '1', 07:29:03 INFO - 'TERM': 'linux', 07:29:03 INFO - 'TMOUT': '86400', 07:29:03 INFO - 'USER': 'cltbld', 07:29:03 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368', 07:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:03 INFO - '_': '/tools/buildbot/bin/python'} 07:29:03 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/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 07:29:03 INFO - mozversion application_buildid: 20160506064620 07:29:03 INFO - mozversion application_changeset: f97139bf14beb480b3255c69b3e43f376c548e31 07:29:03 INFO - mozversion application_display_name: Nightly 07:29:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:29:03 INFO - mozversion application_name: Firefox 07:29:03 INFO - mozversion application_remotingname: firefox 07:29:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:29:03 INFO - mozversion application_vendor: Mozilla 07:29:03 INFO - mozversion application_version: 49.0a1 07:29:03 INFO - mozversion platform_buildid: 20160506064620 07:29:03 INFO - mozversion platform_changeset: f97139bf14beb480b3255c69b3e43f376c548e31 07:29:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:29:03 INFO - mozversion platform_version: 49.0a1 07:29:03 INFO - using testdate: 1462544943 07:29:03 INFO - actual date: 1462544943 07:29:03 INFO - starting webserver on 'localhost:34354' 07:29:03 INFO - SUITE-START | Running 2 tests 07:29:03 INFO - TEST-START | dromaeo_css 07:29:03 INFO - operating with platform_type : linux_ 07:29:03 INFO - Initialising browser for dromaeo_css test... 07:29:03 INFO - TEST-INFO | started process 4840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgeudDO/profile http://localhost:34354/getInfo.html) 07:29:08 INFO - PROCESS | 4840 | 07:29:08 INFO - PROCESS | 4840 | (process:4909): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:29:08 INFO - PROCESS | 4840 | __metrics Screen width/height:1600/1200 07:29:08 INFO - PROCESS | 4840 | colorDepth:24 07:29:08 INFO - PROCESS | 4840 | Browser inner width/height: 1024/697 07:29:08 INFO - PROCESS | 4840 | __metrics 07:29:09 ERROR - PROCESS | 4840 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 07:29:10 INFO - TEST-INFO | 4840: exit 0 07:29:10 INFO - Browser initialized. 07:29:10 INFO - Running cycle 1/1 for dromaeo_css test... 07:29:10 INFO - TEST-INFO | started process 4960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgeudDO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:12 INFO - PROCESS | 4960 | 07:29:12 INFO - PROCESS | 4960 | (process:5020): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:29:22 INFO - PROCESS | 4960 | RSS: Main: 164581376 07:29:22 INFO - PROCESS | 4960 | 07:30:11 INFO - PROCESS | 4960 | 1462545011941 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:32:23 INFO - PROCESS | 4960 | Cycle 1(1): loaded http://localhost:34354/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34354/tests/dromaeo/cssquery-ext.html) 07:32:24 INFO - PROCESS | 4960 | RSS: Main: 167190528 07:32:24 INFO - PROCESS | 4960 | 07:35:26 INFO - PROCESS | 4960 | Cycle 1(1): loaded http://localhost:34354/tests/dromaeo/cssquery-ext.html (next: http://localhost:34354/tests/dromaeo/cssquery-jquery.html) 07:35:27 INFO - PROCESS | 4960 | RSS: Main: 167178240 07:35:27 INFO - PROCESS | 4960 | 07:38:29 INFO - PROCESS | 4960 | Cycle 1(1): loaded http://localhost:34354/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34354/tests/dromaeo/cssquery-mootools.html) 07:38:30 INFO - PROCESS | 4960 | RSS: Main: 168177664 07:38:30 INFO - PROCESS | 4960 | 07:41:31 INFO - PROCESS | 4960 | Cycle 1(1): loaded http://localhost:34354/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34354/tests/dromaeo/cssquery-prototype.html) 07:41:32 INFO - PROCESS | 4960 | RSS: Main: 165785600 07:41:32 INFO - PROCESS | 4960 | 07:44:35 INFO - PROCESS | 4960 | Cycle 1(1): loaded http://localhost:34354/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34354/tests/dromaeo/cssquery-yui.html) 07:44:35 INFO - PROCESS | 4960 | RSS: Main: 167796736 07:44:35 INFO - PROCESS | 4960 | 07:47:38 INFO - PROCESS | 4960 | Cycle 1(1): loaded http://localhost:34354/tests/dromaeo/cssquery-yui.html (next: http://localhost:34354/tests/dromaeo/cssquery-dojo.html) 07:47:38 INFO - PROCESS | 4960 | RSS: Main: 169234432 07:47:38 INFO - PROCESS | 4960 | 07:47:38 INFO - PROCESS | 4960 | __start_tp_report 07:47:38 INFO - PROCESS | 4960 | _x_x_mozilla_page_load 07:47:38 INFO - PROCESS | 4960 | _x_x_mozilla_page_load_details 07:47:38 INFO - PROCESS | 4960 | |i|pagename|runs| 07:47:38 INFO - PROCESS | 4960 | |0;dojo.html;2637.8417294962305;2666.546687063199;2675.398035442026;2675.9063432779844;2687.3013016615687;4745.833895813647;4753.144434001878;4783.473817880031;4849.248366503189;4858.24697171938;4743.7153770773775;4753.928691069636;4768.284757286408;4804.495527969557;4813.326134341186;4377.080813029268;4437.290033594625;4489.079738653568;4512.7743612819395;4524.5249248828895;648.7823990402776;4295.634871035965;4333.544977777336;4370.6940514164025;4436.689431739779;4338.067315527145;4359.6076353128055;4369.038811461473;4376.6498680105515;4417.2269852775635;4375;4423.424954755893;4437.733735975852;4444.2222611042935;4483.058557702886;4314.78426078698;4422.09347083847;4431.689781715281;4443.533428989974;4471.0610771737975;4627.514111018329;4630.560096790799;4651.348811166439;4685.789139488731;4735.73953432561;5200.167973124282;5204.609654275944;5204.687718736888;5205.427402985669;5217.373915130171;5213.817516386908;5219.399769026572;5223.190405487156;5225.5035771602015;5280.419153893069;4662.743549104764;4743.1225223333795;4770.522947705202;4785.1625965455905;4867.9269810952865;5247.239150323182;5255.39562950258;5260.368755749258;5320.441353657888;5321.680699158062;5099.515546023122;5103.234514822732;5109.310243117132;5111.693298402108;5129.487051294841;5149.201873709581;5156.2523434102595;5200.97399513;5221.869453263699;5237.869053273698;5118.309028281209;5137.51193636604;5147.819826306061;5156.303898973665;5174.611904107207;4951.876203094879;5043.142665746832;5148.510891465305;5159.355080614923;5160.432352441228;4357.542458041923;4384.758838263862;4391.209582275221;4405.140997505519;4429.313456414261;3855.1133239354544;3863.2273545291055;3906.8437262509183;3912.315344814646;3927.5286965563746;4334.501532323823;4436.0462500562535;4444.488883778342;4473.261911784519;4526.932096018562;4970.652054356233;5032;5110.565601923878;5131.076406246912;5207.3490813648295;4423.424954755926;4426.579474949875;4440.378347031418;4442.755648439367;4485.955140448554;4572.839950601713;4629.120467111238;4629.77311012582;4647.09381670571;4695.600873925686;4786.784594693317;4797.304390863305;4803.207470767285;4836.879078023077;4842.201036828884;5090.669106508065;5149.87125321855;5179.81870634526;5181.06740786662;5186.092433824141;4659.068186362673;4742.66801323904;4759.214729569582;4801.639877009308;4856.1016212000895;5083.433640164015;5097.592192624656;5108.719020453911;5112.642115051911;5142.562882154909;5184.429712731521;5186.792528298825;5189.662671926313;5190.844274671766;5191.896162076813;4874.122657921608;4944.653874228769;4967;4977.402711674622;4997.2504124380175;4969.900601988013;5004.724740139181;5008.474110218521;5017.42299635532;5073.949260507347;4752.405949256343;4923.310736496965;4947.1589829729755;4950.257461380822;4961.404631444249;4951.678140920829;4959.107360675113;4983.725895075806;4992.151334273255;4998.2502624606595;4822.662413631012;4835.516448355277;4855.684380515255;4864.27035944597;4909.77905994224 07:47:38 INFO - PROCESS | 4960 | |1;ext.html;605.666883214232;619.4177473175215;622.8131560531839;623.990640140398;656.5371413153728;36169.27661446773;37050;39703.60296397035;39738.403923941165;39847.80076099623;39863.80068099655;40569;40774.388384174265;41019.794901025525;41090.794546027304;7722.382209423233;7862.410319226053;7875.251851074138;7921.247481489249;7926.405519586026;7749.186335434782;7884.250996155356;7932.20677932205;7940.801479962989;7949.602519874012;7876.488028278172;7897.131315555284;7922.881156782653;7930.881036784453;7972.3622110231045;7846.843063138734;7857.567833769141;7862.960685196537;7915.485493442908;7917.841643167162;7764.534127952341;7838.8432231355055;7851.528908265523;7861.174576669482;7862.331701805353;36660.266794663956;36797.63202367969;36906.26187476236;36912.815435922916;36928;2486.5151295497385;2962.9259268518244;3296.192432853942;3300.290437555937;3376.932461350784;29516.26209344762;29547.70452295471;29834.95577654772;29899.850500747576;29952.550711739343;3339.916502087443;3409.9829500852584;3443.776154549946;3475.079104037432;3511;231942;232363;232598.9999999983;233261;234207;32081.35837283288;35127.82436087854;35157.29685406278;35184;35307.11732206664;31947.840260798548;32487.675123248937;32510;32577;32718.83640581782;14466.638334041523;14492.420303187755;14671.486497972519;14722.779158312635;14727.705445891022;11758.58844940423;11816.586419475278;11821.290722556674;11873.228240164362;11960.521579136912;8361.95819020901;8477.321814254845;8494.320454363637;8506.31949444043;8568.52873091986;3274.1650879025697;3280.4423248047888;3284.080457471912;3315.751318651111;3342.4317865962844;919.7470695558775;956.5552018311519;958.6165533786402;1064.505005172583;1106.8893110689028;29968.100956971324;30069.097927062223;30169.245768855515;30303.848480757457;30529.23676908095;958.1903291718487;1046.4715318763976;1050.8528805967171;1056.857324261215;1060.183658582887;14997.625059373384;15055.171965542;15283.694326113415;15609.063456192438;15714;357533;676038;686392;693577;694219;54236.45763542393;54540;54909;55090.449095508535;55318.17022744662;1316.5984374765787;1329.2157627000117;1337.097459215026;1352.1819299323963;1355.5052405871786;29492.115236542937;30648.693513065475;30802.537961930142;31023;31266.843665781525;46012.53987460083;46579.06841863076;46651.76674116608;46833.297500536835;46942.76528617335;356364;363477;364128;365890;366151;26971.190864274104;27091.59362609602;27098;27228.31929201786;27289.727102728717;44941.77529112333;45749;46467;46734.76632616815;46823.29765053595;38488.123101438505;39213;39329.60670393259;40150;40631.39052914149;38572.42141367938;38580.421293680054;39626.2074758509;39950.40074398944;40314;33402.33195336128;38075.42886856755;39003.41494877522;39065.414018789175;39150.2169956605;32529.34941301208;34913.8254308737;35333.29333413369;35418.29163416666;35722.285554288246;26098.73901261039;26608.733912660624;26802.731972680023;26837.86581067082;27157.86421067882 07:47:38 INFO - PROCESS | 4960 | |2;jquery.html;375.4612131591167;379.7038310118108;382.5103867050175;385.6644719094388;391.2429449016156;16355.264013119424;16501.257443415045;17228.569285767862;17466.03936783478;17471.650566988654;12278.263304201753;15408.614784630361;15839.445619403323;15883;16514.256858441368;4705.082508910764;4827.686200396981;4879.853604391857;4881;4894.902101957959;3465.618781933998;5256.684598924057;5564.443555644423;5573.665580065189;5606.467385598362;5621.325440947092;5631.521320687726;5635.802746903859;5639.210510528529;5657.462541058593;5969.253843269591;6044.365341639131;6085.087236914454;6116.510679145657;6128.417800308964;4699.224627936386;5011.899762004776;5417.160340147283;5424.701641409721;5425.701586412746;12237.082218833622;12349.93825030869;12552.874471255262;12673.112882098258;12703.618891433272;1914.1099388784282;1927.4603111128906;1940.631280056799;2015.3147929703825;2027.9898600506904;9382.390144640576;9690.273229507744;9964.352317099365;10957.452127393599;13857.514986975508;1719.2693105430142;1797.074506629087;1803.7925638551603;1805;1844.8431883289936;64683;67844.3215567843;68642;68918.65540672315;69771.30228697699;10156.339837910513;10185.388876667275;10400.791984160425;10502;10600.310979786289;14299.142051476945;14366.209858457885;14390.208538530482;14399.208043557495;14426.567202983928;7481.625918704043;7774.6890124394395;7777.066751989684;7853.253940875607;7905.249001344863;7261.41908647307;7348;7471.551706897603;7510.586917719578;7526.774196774106;4272.316429371285;4410.757408342508;4469.4860091089295;4519.909601807945;4551.4765801932535;1620.8622267107428;1781.2251670523106;1908.8472922166193;1913.4451009207453;1926.3546711851407;789.2856964447185;942.1661829280998;978.6770365779275;981.254246772458;1031.9122874555746;16019.279132439067;16491.5877103071;16742.162891855358;17017.91491042537;17089.06010169428;869.9565021748887;932.4964519159578;934.7149119518613;986.7187851462298;993.9353941993747;9431.76420589477;9484;9593.184579310697;9658.77848094942;9738.269629777795;380532;388788;391907;392095;394030;78487.60756196182;78720.6063969688;79994;80144;80419.59790201012;936.7377134402378;957.5738796235609;975.8341082016216;992.1665800727424;996.8355221388534;14802.851971480148;14952.775708364166;15036.924815375853;15245.923770381078;15256.618584535476;26874.596881046407;29041.854790725913;34828.303433930676;34831.30337393289;35716;44665.33002005037;47362.289565655854;47420.52579474299;53569.73215133899;54169.45830541644;7585.848283034198;7660.425468089804;7676.078870535572;7723.420743444377;7730.806729831799;9973.401595904268;11907.46416411281;12024.579139730067;12037.939810301243;12330.63008109758;10322.690319290434;10507.684769456928;10511.369317840954;10572.207084468542;10890.128789696964;10369.63706270277;10590.152787777113;10667.946660266649;10746.355218686904;10787;10662.8400573993;10883.510242038968;10979.890201097887;11041.889581104086;11066;7804.765857024298;7837.804054898673;7925.484843485386;8006.719764808204;8093.919060809317;7948.8807667883875;9768.80462390734;10853.837192441963;10965.122790176607;11116.61091861781 07:47:38 INFO - PROCESS | 4960 | |3;mootools.html;1508.0800711565946;1534.0872181052273;1712.6232228909644;1822.5625849796054;1830.5881176735245;6673.132492775932;7319.670614822332;7438;7844.215578442153;7888;7502.849943001151;7636.198199189089;7668.194839541851;7718.421118416113;7737.806554836132;2140.090461553841;2164.6861205125247;2165.631842586756;2166.555856049506;2179.9455013624706;2180.7928246816605;2209.635410157322;2228.6211344071467;2239.7984181423667;2242.495438526327;2125.0543508138885;2126.734158230221;2139.1336508713994;2182.7053347798083;2259.0850705464313;2139.272647299918;2143.8928053597338;2148.581026699794;2151.9784802151935;2153.536989547255;2094.5915546468445;2149.365937048559;2168.1002384010617;2176.3906106290265;2185.715856938604;7648.655810488542;7655.961720191363;7681.846363072707;7684.193159718261;7716.035495563055;4300.118475712503;4360.106178233486;4470.061287129706;4470.41884555009;4472.82108715651;2760.3375189954468;2784.484870299001;2848.344880677456;2855.34327104765;2856.371598248382;931.0735817861204;946.7396465971844;1617.8382161783845;1800.97298540522;1832.8167183281698;9966.601335946625;10043.548040338203;10061.39631622105;10077.042680945298;10099.0910818026;3919.1573811630637;3954.9209015820097;3959.4654721612214;4036.233115708065;4080.7959602019782;8128.227818357246;8167.83664326722;8196.877046844302;8201.630926608317;8227.794305142419;4451.221036318696;4491.887702807456;4497.168023915586;4501.144782491317;4506.909861802746;3702.777833330009;3894.6689531389584;4029.738067025634;4140.91718165635;4153.68847336451;3457.187560923181;3483;3537.2748586539697;3576.409892367782;3599.460080987873;1058.0424715632364;1058.1270451877233;1065.8507808906759;1077.06833588945;1082.0477979378097;878.3939082033377;912.3157631776168;913.159892898535;927.9211267042242;930.5951910918772;5311.787528498894;5329.440408757102;5354.759035843396;5399.70301633414;5401.5948803839865;885.2165833237631;938.8169306985072;959.1703176752059;1003.2926786615419;1003.5584342889106;3593.7125029997537;3717.7955212463035;3725.795081270502;3729.5710993236125;3748.9625103748613;9164.258790829721;9301.767455813659;9306.06939306064;9338.626454941726;9440.24478041755;9267.397619154868;9292.814143717087;9333.393329433566;9339.439633622005;9340.4862732549;6707.899381509281;7074.22183559808;7109.644517774194;7128.6435678215885;7236.891446628305;5108.463611320906;5276.314079169683;5372.838814835562;5411.675299482044;5447.073997420369;8563.657453701782;8722.127787221227;8763.780905477413;8794.944606647243;8850.291976641724;8651.134886511298;8917.10828917103;8917.821643567222;8929.374943753875;9018.774530636787;5799.9130013049;6390.201224846895;6451.0645956337;6560.868782624416;6670.433013193933;7353.6690848912995;7375.188729239672;7445.367143792838;7455.962720186364;7484.43866709988;6607;6634.966825165843;6642.800715978528;6728.125343705287;6736.225334086446;6635.63504007265;6674.466042716474;6716.731330746716;6783.728650853911;6810.62541560219;6295.401936815995;6383.457406120532;6408.070829729756;6433.13152724395;6435.678216089271;4560.3843481129625;4609.124266389375;4611.2852507861335;4710.9764451177525;4792.880177995578;4645.187092258773;4688.132695451216;4776.140294746979;4786.018866132504;4841.298011788342 07:47:38 INFO - PROCESS | 4960 | |4;prototype.html;304.6785641148589;314.6255955413058;314.78909130882306;315.83892214970365;317.9157523256336;4702.976485117578;4917.582005529534;4949.604031677466;5018.515834661843;5033.974830125853;4690.273007683806;4878.195097808857;4890.633202509817;4919.212925931852;4927.5072492750705;3916.5887581803786;3939.4287828264883;3941.783201923893;3962.286788378091;3962.5140572285395;3660.469231961364;3907.804609769514;3918.921621567567;3930.842766289345;3949.842006319758;3801.714871384643;3809.866654667087;3831.7700937943673;3833.5208098987628;3840.577536470986;3810.637989391017;3815.4086116651965;3820.102275965146;3837.2901013312485;3862.671672907806;3370.3090866372336;3389.3390788796196;3410.471376936579;3412.8293585320885;3417.419038763391;4623.583877451046;4678.836240731558;4695.225287827504;4708.434987801452;4769.809207631691;4295.656347492224;4336.696431249814;4398.164348773723;4400.977995110036;4412.3160910059;5093.898122037575;5121.8719532012;5122.667026643257;5128.179491281415;5145.665531740425;3616.0959760059986;3644.4511082789973;3696.482492451059;3698.223373091654;3700.112942399369;5353.571714262888;5387.488188622075;5390.299261096072;5395.244665746799;5420.430854760233;3764.604716504782;3783.8297276622066;3795.7532760370486;3801.6008319126095;3815.1606646537716;3794.3359912015285;3823.667562786698;3825.3305671507374;3831.080540670219;3835.5972622874756;4032.536258330271;4304.16068866568;4323.805428755713;4337.327714204303;4375.146846364992;5181.171012638035;5198.428172900978;5210.452902445264;5211.7915283389;5212;1208.905940124189;1264.2161859647078;1285.7364240330896;1288.368699337318;1288.4731593062063;861.9482831030158;874.8119154381839;875.9824803503894;876.7238319929202;879.4723166100289;4390.692651514427;4407.250767369491;4416.492103408085;4417.779111044435;4430.401895744098;5158.6131040171385;5164.546840250926;5192.61055420845;5193.533071790869;5197.324347834833;4375.365571992043;4441.356003379492;4454.354118652777;4455.309427038814;4456.688031837805;2615;2750.752432281104;2780.541210700252;2783.7355451232506;2785.818921770119;4877.073356062337;4882.829100981519;4892.241702536041;4899.485554016777;4970.751462426864;5226.738663066832;5296.92054619181;5313.760880760375;5344.518993290622;5386.165144402624;5002.799888004512;5014.648974571745;5023.949760502422;5030.339987804015;5044.873878153076;5390.407055224001;5420;5435.130379139318;5449.509544140888;5463.098588732814;5200.349956255468;5233.162693968947;5237.659552129099;5312.814051508179;5328.4671532846405;4967.254911763264;5003.524665156804;5015;5015.442124516596;5023.547880690755;3697.8705745298785;3706.814659266972;3737.7757334560015;3754.6433088856515;3772.2078363542864;5125.769340379767;5358.705271210121;5426.565874729933;5435.945640543702;5448.754806033818;5195.636305458582;5216.843494695014;5237.590708274237;5248.343957005374;5277.313949186735;5182.367554220408;5235.267062611161;5239.82104026591;5243.265942768092;5252.711100889488;4793.304970779287;5113.386393632788;5127.2052831811125;5136.434992150786;5164.251183578435;5181.715005674573;5206.589683757145;5208.661437006734;5226.790928362823;5268.604854635994;5080.618953578422;5110.872228194325;5117.925235700544;5140.485951404829;5145.61407894402 07:47:38 INFO - PROCESS | 4960 | |5;yui.html;719.9460040496961;736.4881407421838;745.2547452547452;786.5713186313459;822.3708862720018;11825.113116516264;12672;12679.556215532459;12682;12725.809112863315;12643;12672.112952093334;12682.80975785364;12683.809742853842;12735.490580376798;671.7145213284359;823.9093699693029;849.413904405961;853.5134973065356;855.9400841941067;853.8804567360575;856.4133568505563;859.072202021815;862.2024627219797;864.1617630898019;921.2952091649893;922.6032805893464;922.7693076730817;922.9630814767402;925.8611208318772;908.68650315641;911.011552465569;912.2382810353363;912.4388501071826;913.7213149989251;677.1062197898775;677.5697432130584;678.0236459498307;678.3216783216783;678.5792808458738;12941.48234070636;12965.22208667483;12967.351632418342;13035.543755968496;13045.673858153526;12884.291363974977;12965.675858103528;13018.15382000167;13050.673733156747;13119.409626566732;10130.898691013143;10194.235432342604;10219.335743176744;10265.794684106351;10388.79222415555;3385.779924304912;3410.07927859479;3473.826308684581;3474.3051389722154;3481.1819222482695;42975;43011.784941075406;43089.56910430887;43240;44761.32858007165;10171.084602385672;10360;10410.115140213014;10431.321964072311;10451.850296467383;18188.1815318311;18271.725924110884;18279.54301142482;18281.3601523946;18431.26274949014;6720.126383570202;6889.965550172217;6915.723371065202;6928;7149.82125446868;3755.3991361382596;3761.3229618668356;3773.5471743390967;3838.136419305634;3901.0637447012514;2827.3214428537003;2957.3937342844665;2958.1717119206655;2966.8664910079096;2967.451021561018;526.507715286201;539.3016044222662;543.8341305901658;544.083219774681;552.5579536370967;584.9181114643953;596.9970150149309;601.5668718522656;611.1382950040422;618.4588485075559;7385.926140738631;7399.7040118395735;7632.618369081523;7667.463277570517;7737.806554836174;526.8340472751071;541.3449725831788;574.2764117212259;589.9675517846559;648.2739331948154;3712.3317802795755;3848.592944906868;3937.3897045957924;3953.3872249801325;4096.487939007624;52302.73848630809;53152.202716958505;53358.733206333716;54502;54786.45213547813;46748.76625616918;48681.756591216814;48984;49253.50746492489;49554;43407.348889766676;44927;45706.31440528395;46174;46179.30731039037;7900.802479938047;7988.560629165451;8275;8424.747257582283;8625.482471051757;29775.851120744257;29813.5527967085;30217.09348719542;30246.243843903198;30320.241993950327;39109.804450977565;39391.212175755754;39561.81314560568;40114.79942600268;40188.397174043;10295.485225738832;10470.371777693363;10633.308834925705;10936.726581835517;11355.829662555234;12191.390430478617;12245.14284000147;12322;12639.747205056032;13039.348032598522;10885.346879187275;11297.887021130013;11393.487293071666;11948.223365481215;12037.819432708342;11372.715682108013;11634.185607007428;11969.042476602026;12101.757964840477;12368.81446778317;9906.603735850773;10443.164546836082;10605.41670208146;10859.185561083108;11643.76712465729;8968.327375446737;8975;8996.86504702443;9247.491387973727;9323.487208203615;8795.47227166372;9155.359124861196;9216.30877684163;9282.21101206405;9411.29415293842 07:47:38 INFO - PROCESS | 4960 | __end_tp_report 07:47:38 INFO - PROCESS | 4960 | __start_cc_report 07:47:38 INFO - PROCESS | 4960 | _x_x_mozilla_cycle_collect,375 07:47:38 INFO - PROCESS | 4960 | __end_cc_report 07:47:38 INFO - PROCESS | 4960 | __startTimestamp1462546058860__endTimestamp 07:47:38 INFO - PROCESS | 4960 | 07:47:38 INFO - PROCESS | 4960 | ------- Summary: start ------- 07:47:38 INFO - PROCESS | 4960 | Number of tests: 6 07:47:38 INFO - PROCESS | 4960 | 07:47:38 INFO - PROCESS | 4960 | [#0] dojo.html Cycles:165 Average:4723.78 Median:4842.20 stddev:591.96 (12.2%) stddev-sans-first:570.71 07:47:38 INFO - PROCESS | 4960 | Values: 2637.8 2666.5 2675.4 2675.9 2687.3 4745.8 4753.1 4783.5 4849.2 4858.2 4743.7 4753.9 4768.3 4804.5 4813.3 4377.1 4437.3 4489.1 4512.8 4524.5 648.8 4295.6 4333.5 4370.7 4436.7 4338.1 4359.6 4369.0 4376.6 4417.2 4375.0 4423.4 4437.7 4444.2 4483.1 4314.8 4422.1 4431.7 4443.5 4471.1 4627.5 4630.6 4651.3 4685.8 4735.7 5200.2 5204.6 5204.7 5205.4 5217.4 5213.8 5219.4 5223.2 5225.5 5280.4 4662.7 4743.1 4770.5 4785.2 4867.9 5247.2 5255.4 5260.4 5320.4 5321.7 5099.5 5103.2 5109.3 5111.7 5129.5 5149.2 5156.3 5201.0 5221.9 5237.9 5118.3 5137.5 5147.8 5156.3 5174.6 4951.9 5043.1 5148.5 5159.4 5160.4 4357.5 4384.8 4391.2 4405.1 4429.3 3855.1 3863.2 3906.8 3912.3 3927.5 4334.5 4436.0 4444.5 4473.3 4526.9 4970.7 5032.0 5110.6 5131.1 5207.3 4423.4 4426.6 4440.4 4442.8 4486.0 4572.8 4629.1 4629.8 4647.1 4695.6 4786.8 4797.3 4803.2 4836.9 4842.2 5090.7 5149.9 5179.8 5181.1 5186.1 4659.1 4742.7 4759.2 4801.6 4856.1 5083.4 5097.6 5108.7 5112.6 5142.6 5184.4 5186.8 5189.7 5190.8 5191.9 4874.1 4944.7 4967.0 4977.4 4997.3 4969.9 5004.7 5008.5 5017.4 5073.9 4752.4 4923.3 4947.2 4950.3 4961.4 4951.7 4959.1 4983.7 4992.2 4998.3 4822.7 4835.5 4855.7 4864.3 4909.8 07:47:38 INFO - PROCESS | 4960 | 07:47:38 INFO - PROCESS | 4960 | [#1] ext.html Cycles:180 Average:54101.10 Median:363802.50 stddev:119308.17 (32.8%) stddev-sans-first:119575.25 07:47:38 INFO - PROCESS | 4960 | Values: 605.7 619.4 622.8 624.0 656.5 36169.3 37050.0 39703.6 39738.4 39847.8 39863.8 40569.0 40774.4 41019.8 41090.8 7722.4 7862.4 7875.3 7921.2 7926.4 7749.2 7884.3 7932.2 7940.8 7949.6 7876.5 7897.1 7922.9 7930.9 7972.4 7846.8 7857.6 7863.0 7915.5 7917.8 7764.5 7838.8 7851.5 7861.2 7862.3 36660.3 36797.6 36906.3 36912.8 36928.0 2486.5 2962.9 3296.2 3300.3 3376.9 29516.3 29547.7 29835.0 29899.9 29952.6 3339.9 3410.0 3443.8 3475.1 3511.0 231942.0 232363.0 232599.0 233261.0 234207.0 32081.4 35127.8 35157.3 35184.0 35307.1 31947.8 32487.7 32510.0 32577.0 32718.8 14466.6 14492.4 14671.5 14722.8 14727.7 11758.6 11816.6 11821.3 11873.2 11960.5 8362.0 8477.3 8494.3 8506.3 8568.5 3274.2 3280.4 3284.1 3315.8 3342.4 919.7 956.6 958.6 1064.5 1106.9 29968.1 30069.1 30169.2 30303.8 30529.2 958.2 1046.5 1050.9 1056.9 1060.2 14997.6 15055.2 15283.7 15609.1 15714.0 357533.0 676038.0 686392.0 693577.0 694219.0 54236.5 54540.0 54909.0 55090.4 55318.2 1316.6 1329.2 1337.1 1352.2 1355.5 29492.1 30648.7 30802.5 31023.0 31266.8 46012.5 46579.1 46651.8 46833.3 46942.8 356364.0 363477.0 364128.0 365890.0 366151.0 26971.2 27091.6 27098.0 27228.3 27289.7 44941.8 45749.0 46467.0 46734.8 46823.3 38488.1 39213.0 39329.6 40150.0 40631.4 38572.4 38580.4 39626.2 39950.4 40314.0 33402.3 38075.4 39003.4 39065.4 39150.2 32529.3 34913.8 35333.3 35418.3 35722.3 26098.7 26608.7 26802.7 26837.9 27157.9 07:47:38 INFO - PROCESS | 4960 | 07:47:38 INFO - PROCESS | 4960 | [#2] jquery.html Cycles:180 Average:24028.27 Median:199151.16 stddev:64318.13 (32.3%) stddev-sans-first:64474.04 07:47:38 INFO - PROCESS | 4960 | Values: 375.5 379.7 382.5 385.7 391.2 16355.3 16501.3 17228.6 17466.0 17471.7 12278.3 15408.6 15839.4 15883.0 16514.3 4705.1 4827.7 4879.9 4881.0 4894.9 3465.6 5256.7 5564.4 5573.7 5606.5 5621.3 5631.5 5635.8 5639.2 5657.5 5969.3 6044.4 6085.1 6116.5 6128.4 4699.2 5011.9 5417.2 5424.7 5425.7 12237.1 12349.9 12552.9 12673.1 12703.6 1914.1 1927.5 1940.6 2015.3 2028.0 9382.4 9690.3 9964.4 10957.5 13857.5 1719.3 1797.1 1803.8 1805.0 1844.8 64683.0 67844.3 68642.0 68918.7 69771.3 10156.3 10185.4 10400.8 10502.0 10600.3 14299.1 14366.2 14390.2 14399.2 14426.6 7481.6 7774.7 7777.1 7853.3 7905.2 7261.4 7348.0 7471.6 7510.6 7526.8 4272.3 4410.8 4469.5 4519.9 4551.5 1620.9 1781.2 1908.8 1913.4 1926.4 789.3 942.2 978.7 981.3 1031.9 16019.3 16491.6 16742.2 17017.9 17089.1 870.0 932.5 934.7 986.7 993.9 9431.8 9484.0 9593.2 9658.8 9738.3 380532.0 388788.0 391907.0 392095.0 394030.0 78487.6 78720.6 79994.0 80144.0 80419.6 936.7 957.6 975.8 992.2 996.8 14802.9 14952.8 15036.9 15245.9 15256.6 26874.6 29041.9 34828.3 34831.3 35716.0 44665.3 47362.3 47420.5 53569.7 54169.5 7585.8 7660.4 7676.1 7723.4 7730.8 9973.4 11907.5 12024.6 12037.9 12330.6 10322.7 10507.7 10511.4 10572.2 10890.1 10369.6 10590.2 10667.9 10746.4 10787.0 10662.8 10883.5 10979.9 11041.9 11066.0 7804.8 7837.8 7925.5 8006.7 8093.9 7948.9 9768.8 10853.8 10965.1 11116.6 07:47:38 INFO - PROCESS | 4960 | 07:47:38 INFO - PROCESS | 4960 | [#3] mootools.html Cycles:180 Average:5050.02 Median:5294.05 stddev:2727.05 (51.5%) stddev-sans-first:2721.71 07:47:38 INFO - PROCESS | 4960 | Values: 1508.1 1534.1 1712.6 1822.6 1830.6 6673.1 7319.7 7438.0 7844.2 7888.0 7502.8 7636.2 7668.2 7718.4 7737.8 2140.1 2164.7 2165.6 2166.6 2179.9 2180.8 2209.6 2228.6 2239.8 2242.5 2125.1 2126.7 2139.1 2182.7 2259.1 2139.3 2143.9 2148.6 2152.0 2153.5 2094.6 2149.4 2168.1 2176.4 2185.7 7648.7 7656.0 7681.8 7684.2 7716.0 4300.1 4360.1 4470.1 4470.4 4472.8 2760.3 2784.5 2848.3 2855.3 2856.4 931.1 946.7 1617.8 1801.0 1832.8 9966.6 10043.5 10061.4 10077.0 10099.1 3919.2 3954.9 3959.5 4036.2 4080.8 8128.2 8167.8 8196.9 8201.6 8227.8 4451.2 4491.9 4497.2 4501.1 4506.9 3702.8 3894.7 4029.7 4140.9 4153.7 3457.2 3483.0 3537.3 3576.4 3599.5 1058.0 1058.1 1065.9 1077.1 1082.0 878.4 912.3 913.2 927.9 930.6 5311.8 5329.4 5354.8 5399.7 5401.6 885.2 938.8 959.2 1003.3 1003.6 3593.7 3717.8 3725.8 3729.6 3749.0 9164.3 9301.8 9306.1 9338.6 9440.2 9267.4 9292.8 9333.4 9339.4 9340.5 6707.9 7074.2 7109.6 7128.6 7236.9 5108.5 5276.3 5372.8 5411.7 5447.1 8563.7 8722.1 8763.8 8794.9 8850.3 8651.1 8917.1 8917.8 8929.4 9018.8 5799.9 6390.2 6451.1 6560.9 6670.4 7353.7 7375.2 7445.4 7456.0 7484.4 6607.0 6635.0 6642.8 6728.1 6736.2 6635.6 6674.5 6716.7 6783.7 6810.6 6295.4 6383.5 6408.1 6433.1 6435.7 4560.4 4609.1 4611.3 4711.0 4792.9 4645.2 4688.1 4776.1 4786.0 4841.3 07:47:38 INFO - PROCESS | 4960 | 07:47:38 INFO - PROCESS | 4960 | [#4] prototype.html Cycles:180 Average:4281.30 Median:4886.73 stddev:1251.31 (25.6%) stddev-sans-first:1218.70 07:47:38 INFO - PROCESS | 4960 | Values: 304.7 314.6 314.8 315.8 317.9 4703.0 4917.6 4949.6 5018.5 5034.0 4690.3 4878.2 4890.6 4919.2 4927.5 3916.6 3939.4 3941.8 3962.3 3962.5 3660.5 3907.8 3918.9 3930.8 3949.8 3801.7 3809.9 3831.8 3833.5 3840.6 3810.6 3815.4 3820.1 3837.3 3862.7 3370.3 3389.3 3410.5 3412.8 3417.4 4623.6 4678.8 4695.2 4708.4 4769.8 4295.7 4336.7 4398.2 4401.0 4412.3 5093.9 5121.9 5122.7 5128.2 5145.7 3616.1 3644.5 3696.5 3698.2 3700.1 5353.6 5387.5 5390.3 5395.2 5420.4 3764.6 3783.8 3795.8 3801.6 3815.2 3794.3 3823.7 3825.3 3831.1 3835.6 4032.5 4304.2 4323.8 4337.3 4375.1 5181.2 5198.4 5210.5 5211.8 5212.0 1208.9 1264.2 1285.7 1288.4 1288.5 861.9 874.8 876.0 876.7 879.5 4390.7 4407.3 4416.5 4417.8 4430.4 5158.6 5164.5 5192.6 5193.5 5197.3 4375.4 4441.4 4454.4 4455.3 4456.7 2615.0 2750.8 2780.5 2783.7 2785.8 4877.1 4882.8 4892.2 4899.5 4970.8 5226.7 5296.9 5313.8 5344.5 5386.2 5002.8 5014.6 5023.9 5030.3 5044.9 5390.4 5420.0 5435.1 5449.5 5463.1 5200.3 5233.2 5237.7 5312.8 5328.5 4967.3 5003.5 5015.0 5015.4 5023.5 3697.9 3706.8 3737.8 3754.6 3772.2 5125.8 5358.7 5426.6 5435.9 5448.8 5195.6 5216.8 5237.6 5248.3 5277.3 5182.4 5235.3 5239.8 5243.3 5252.7 4793.3 5113.4 5127.2 5136.4 5164.3 5181.7 5206.6 5208.7 5226.8 5268.6 5080.6 5110.9 5117.9 5140.5 5145.6 07:47:38 INFO - PROCESS | 4960 | 07:47:38 INFO - PROCESS | 4960 | [#5] yui.html Cycles:180 Average:13052.33 Median:43050.68 stddev:14745.40 (34.3%) stddev-sans-first:14757.68 07:47:38 INFO - PROCESS | 4960 | Values: 719.9 736.5 745.3 786.6 822.4 11825.1 12672.0 12679.6 12682.0 12725.8 12643.0 12672.1 12682.8 12683.8 12735.5 671.7 823.9 849.4 853.5 855.9 853.9 856.4 859.1 862.2 864.2 921.3 922.6 922.8 923.0 925.9 908.7 911.0 912.2 912.4 913.7 677.1 677.6 678.0 678.3 678.6 12941.5 12965.2 12967.4 13035.5 13045.7 12884.3 12965.7 13018.2 13050.7 13119.4 10130.9 10194.2 10219.3 10265.8 10388.8 3385.8 3410.1 3473.8 3474.3 3481.2 42975.0 43011.8 43089.6 43240.0 44761.3 10171.1 10360.0 10410.1 10431.3 10451.9 18188.2 18271.7 18279.5 18281.4 18431.3 6720.1 6890.0 6915.7 6928.0 7149.8 3755.4 3761.3 3773.5 3838.1 3901.1 2827.3 2957.4 2958.2 2966.9 2967.5 526.5 539.3 543.8 544.1 552.6 584.9 597.0 601.6 611.1 618.5 7385.9 7399.7 7632.6 7667.5 7737.8 526.8 541.3 574.3 590.0 648.3 3712.3 3848.6 3937.4 3953.4 4096.5 52302.7 53152.2 53358.7 54502.0 54786.5 46748.8 48681.8 48984.0 49253.5 49554.0 43407.3 44927.0 45706.3 46174.0 46179.3 7900.8 7988.6 8275.0 8424.7 8625.5 29775.9 29813.6 30217.1 30246.2 30320.2 39109.8 39391.2 39561.8 40114.8 40188.4 10295.5 10470.4 10633.3 10936.7 11355.8 12191.4 12245.1 12322.0 12639.7 13039.3 10885.3 11297.9 11393.5 11948.2 12037.8 11372.7 11634.2 11969.0 12101.8 12368.8 9906.6 10443.2 10605.4 10859.2 11643.8 8968.3 8975.0 8996.9 9247.5 9323.5 8795.5 9155.4 9216.3 9282.2 9411.3 07:47:38 INFO - PROCESS | 4960 | -------- Summary: end -------- 07:47:38 INFO - PROCESS | 4960 | 07:47:39 INFO - TEST-INFO | 4960: exit 0 07:47:39 INFO - TEST-OK | dromaeo_css | took 1115668ms 07:47:39 INFO - TEST-START | kraken 07:47:39 INFO - operating with platform_type : linux_ 07:47:39 INFO - Initialising browser for kraken test... 07:47:39 INFO - TEST-INFO | started process 5197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyplJdZ/profile http://localhost:34354/getInfo.html) 07:47:43 INFO - PROCESS | 5197 | 07:47:43 INFO - PROCESS | 5197 | (process:5263): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:47:44 INFO - PROCESS | 5197 | __metrics Screen width/height:1600/1200 07:47:44 INFO - PROCESS | 5197 | colorDepth:24 07:47:44 INFO - PROCESS | 5197 | Browser inner width/height: 1024/697 07:47:44 INFO - PROCESS | 5197 | __metrics 07:47:44 ERROR - PROCESS | 5197 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 07:47:45 INFO - TEST-INFO | 5197: exit 0 07:47:45 INFO - Browser initialized. 07:47:45 INFO - Running cycle 1/1 for kraken test... 07:47:45 INFO - TEST-INFO | started process 5316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyplJdZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:47 INFO - PROCESS | 5316 | 07:47:47 INFO - PROCESS | 5316 | (process:5376): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:47:57 INFO - PROCESS | 5316 | RSS: Main: 164851712 07:47:57 INFO - PROCESS | 5316 | 07:48:00 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34354/tests/kraken/driver.html?testName=audio-beat-detection) 07:48:01 INFO - PROCESS | 5316 | RSS: Main: 168693760 07:48:01 INFO - PROCESS | 5316 | 07:48:04 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34354/tests/kraken/driver.html?testName=audio-dft) 07:48:04 INFO - PROCESS | 5316 | RSS: Main: 168648704 07:48:04 INFO - PROCESS | 5316 | 07:48:07 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34354/tests/kraken/driver.html?testName=audio-fft) 07:48:08 INFO - PROCESS | 5316 | RSS: Main: 164417536 07:48:08 INFO - PROCESS | 5316 | 07:48:10 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34354/tests/kraken/driver.html?testName=audio-oscillator) 07:48:11 INFO - PROCESS | 5316 | RSS: Main: 163901440 07:48:11 INFO - PROCESS | 5316 | 07:48:13 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34354/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:48:13 INFO - PROCESS | 5316 | RSS: Main: 164962304 07:48:13 INFO - PROCESS | 5316 | 07:48:17 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34354/tests/kraken/driver.html?testName=imaging-darkroom) 07:48:17 INFO - PROCESS | 5316 | RSS: Main: 164655104 07:48:17 INFO - PROCESS | 5316 | 07:48:21 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34354/tests/kraken/driver.html?testName=imaging-desaturate) 07:48:21 INFO - PROCESS | 5316 | RSS: Main: 162992128 07:48:21 INFO - PROCESS | 5316 | 07:48:24 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34354/tests/kraken/driver.html?testName=json-parse-financial) 07:48:25 INFO - PROCESS | 5316 | RSS: Main: 164130816 07:48:25 INFO - PROCESS | 5316 | 07:48:27 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34354/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:48:27 INFO - PROCESS | 5316 | RSS: Main: 164274176 07:48:27 INFO - PROCESS | 5316 | 07:48:29 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34354/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:48:30 INFO - PROCESS | 5316 | RSS: Main: 164151296 07:48:30 INFO - PROCESS | 5316 | 07:48:32 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34354/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:48:33 INFO - PROCESS | 5316 | RSS: Main: 164339712 07:48:33 INFO - PROCESS | 5316 | 07:48:35 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:48:36 INFO - PROCESS | 5316 | RSS: Main: 164409344 07:48:36 INFO - PROCESS | 5316 | 07:48:39 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:48:40 INFO - PROCESS | 5316 | RSS: Main: 165130240 07:48:40 INFO - PROCESS | 5316 | 07:48:41 INFO - PROCESS | 5316 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34354/tests/kraken/driver.html?testName=ai-astar) 07:48:42 INFO - PROCESS | 5316 | RSS: Main: 165945344 07:48:42 INFO - PROCESS | 5316 | 07:48:42 INFO - PROCESS | 5316 | __start_tp_report 07:48:42 INFO - PROCESS | 5316 | _x_x_mozilla_page_load 07:48:42 INFO - PROCESS | 5316 | _x_x_mozilla_page_load_details 07:48:42 INFO - PROCESS | 5316 | |i|pagename|runs| 07:48:42 INFO - PROCESS | 5316 | |0;ai-astar;112;115;103;112;113;113;107;113;115;111 07:48:42 INFO - PROCESS | 5316 | |1;audio-beat-detection;158;136;165;192;132;162;162;131;187;132 07:48:42 INFO - PROCESS | 5316 | |2;audio-dft;165;163;163;164;165;163;162;160;164;160 07:48:42 INFO - PROCESS | 5316 | |3;audio-fft;77;75;76;153;77;78;75;76;153;75 07:48:42 INFO - PROCESS | 5316 | |4;audio-oscillator;93;93;151;93;94;92;147;94;93;140 07:48:42 INFO - PROCESS | 5316 | |5;imaging-gaussian-blur;118;117;118;117;117;117;117;117;118;118 07:48:42 INFO - PROCESS | 5316 | |6;imaging-darkroom;147;154;148;147;149;148;147;146;146;147 07:48:42 INFO - PROCESS | 5316 | |7;imaging-desaturate;95;96;95;95;95;95;96;96;96;96 07:48:42 INFO - PROCESS | 5316 | |8;json-parse-financial;67;67;68;66;67;70;67;85;66;65 07:48:42 INFO - PROCESS | 5316 | |9;json-stringify-tinderbox;63;64;64;63;73;63;64;63;64;63 07:48:42 INFO - PROCESS | 5316 | |10;stanford-crypto-aes;82;89;83;83;84;86;89;83;84;87 07:48:42 INFO - PROCESS | 5316 | |11;stanford-crypto-ccm;132;134;142;131;134;131;133;148;228;149 07:48:42 INFO - PROCESS | 5316 | |12;stanford-crypto-pbkdf2;184;179;176;178;172;173;177;175;175;169 07:48:42 INFO - PROCESS | 5316 | |13;stanford-crypto-sha256-iterative;67;70;70;66;67;67;67;74;74;68 07:48:42 INFO - PROCESS | 5316 | __end_tp_report 07:48:42 INFO - PROCESS | 5316 | __start_cc_report 07:48:42 INFO - PROCESS | 5316 | _x_x_mozilla_cycle_collect,909 07:48:42 INFO - PROCESS | 5316 | __end_cc_report 07:48:42 INFO - PROCESS | 5316 | __startTimestamp1462546122126__endTimestamp 07:48:42 INFO - PROCESS | 5316 | 07:48:42 INFO - PROCESS | 5316 | ------- Summary: start ------- 07:48:42 INFO - PROCESS | 5316 | Number of tests: 14 07:48:42 INFO - PROCESS | 5316 | 07:48:42 INFO - PROCESS | 5316 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.00 stddev:3.72 (3.3%) stddev-sans-first:3.94 07:48:42 INFO - PROCESS | 5316 | Values: 112.0 115.0 103.0 112.0 113.0 113.0 107.0 113.0 115.0 111.0 07:48:42 INFO - PROCESS | 5316 | 07:48:42 INFO - PROCESS | 5316 | [#1] audio-beat-detection Cycles:10 Average:155.70 Median:162.00 stddev:22.58 (13.9%) stddev-sans-first:23.94 07:48:42 INFO - PROCESS | 5316 | Values: 158.0 136.0 165.0 192.0 132.0 162.0 162.0 131.0 187.0 132.0 07:48:42 INFO - PROCESS | 5316 | 07:48:42 INFO - PROCESS | 5316 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.50 stddev:1.79 (1.1%) stddev-sans-first:1.73 07:48:42 INFO - PROCESS | 5316 | Values: 165.0 163.0 163.0 164.0 165.0 163.0 162.0 160.0 164.0 160.0 07:48:42 INFO - PROCESS | 5316 | 07:48:42 INFO - PROCESS | 5316 | [#3] audio-fft Cycles:10 Average:91.50 Median:76.00 stddev:32.43 (42.7%) stddev-sans-first:33.97 07:48:42 INFO - PROCESS | 5316 | Values: 77.0 75.0 76.0 153.0 77.0 78.0 75.0 76.0 153.0 75.0 07:48:42 INFO - PROCESS | 5316 | 07:48:42 INFO - PROCESS | 5316 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:93.00 stddev:25.67 (27.6%) stddev-sans-first:26.57 07:48:42 INFO - PROCESS | 5316 | Values: 93.0 93.0 151.0 93.0 94.0 92.0 147.0 94.0 93.0 140.0 07:48:42 INFO - PROCESS | 5316 | 07:48:42 INFO - PROCESS | 5316 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 07:48:42 INFO - PROCESS | 5316 | Values: 118.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 07:48:42 INFO - PROCESS | 5316 | 07:48:42 INFO - PROCESS | 5316 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:147.50 stddev:2.33 (1.6%) stddev-sans-first:2.45 07:48:42 INFO - PROCESS | 5316 | Values: 147.0 154.0 148.0 147.0 149.0 148.0 147.0 146.0 146.0 147.0 07:48:42 INFO - PROCESS | 5316 | 07:48:42 INFO - PROCESS | 5316 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:48:42 INFO - PROCESS | 5316 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 07:48:42 INFO - PROCESS | 5316 | 07:48:42 INFO - PROCESS | 5316 | [#8] json-parse-financial Cycles:10 Average:68.80 Median:67.00 stddev:5.85 (8.7%) stddev-sans-first:6.16 07:48:42 INFO - PROCESS | 5316 | Values: 67.0 67.0 68.0 66.0 67.0 70.0 67.0 85.0 66.0 65.0 07:48:42 INFO - PROCESS | 5316 | 07:48:42 INFO - PROCESS | 5316 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.00 stddev:3.06 (4.8%) stddev-sans-first:3.21 07:48:42 INFO - PROCESS | 5316 | Values: 63.0 64.0 64.0 63.0 73.0 63.0 64.0 63.0 64.0 63.0 07:48:42 INFO - PROCESS | 5316 | 07:48:42 INFO - PROCESS | 5316 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:2.58 (3.0%) stddev-sans-first:2.50 07:48:42 INFO - PROCESS | 5316 | Values: 82.0 89.0 83.0 83.0 84.0 86.0 89.0 83.0 84.0 87.0 07:48:42 INFO - PROCESS | 5316 | 07:48:42 INFO - PROCESS | 5316 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:138.00 stddev:29.54 (21.4%) stddev-sans-first:30.89 07:48:42 INFO - PROCESS | 5316 | Values: 132.0 134.0 142.0 131.0 134.0 131.0 133.0 148.0 228.0 149.0 07:48:42 INFO - PROCESS | 5316 | 07:48:42 INFO - PROCESS | 5316 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:176.50 stddev:4.13 (2.3%) stddev-sans-first:3.14 07:48:42 INFO - PROCESS | 5316 | Values: 184.0 179.0 176.0 178.0 172.0 173.0 177.0 175.0 175.0 169.0 07:48:42 INFO - PROCESS | 5316 | 07:48:42 INFO - PROCESS | 5316 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:2.94 (4.3%) stddev-sans-first:3.03 07:48:42 INFO - PROCESS | 5316 | Values: 67.0 70.0 70.0 66.0 67.0 67.0 67.0 74.0 74.0 68.0 07:48:42 INFO - PROCESS | 5316 | -------- Summary: end -------- 07:48:42 INFO - PROCESS | 5316 | 07:48:43 INFO - TEST-INFO | 5316: exit 0 07:48:43 INFO - TEST-OK | kraken | took 63525ms 07:48:43 INFO - SUITE-END | took 1179s 07:48:43 INFO - Completed test suite (00:19:39) 07:48:43 INFO - javascript benchmark 07:48:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2637.8417294962305, 2666.546687063199, 2675.398035442026, 2675.9063432779844, 2687.3013016615687, 4745.833895813647, 4753.144434001878, 4783.473817880031, 4849.248366503189, 4858.24697171938, 4743.7153770773775, 4753.928691069636, 4768.284757286408, 4804.495527969557, 4813.326134341186, 4377.080813029268, 4437.290033594625, 4489.079738653568, 4512.7743612819395, 4524.5249248828895, 648.7823990402776, 4295.634871035965, 4333.544977777336, 4370.6940514164025, 4436.689431739779, 4338.067315527145, 4359.6076353128055, 4369.038811461473, 4376.6498680105515, 4417.2269852775635, 4375.0, 4423.424954755893, 4437.733735975852, 4444.2222611042935, 4483.058557702886, 4314.78426078698, 4422.09347083847, 4431.689781715281, 4443.533428989974, 4471.0610771737975, 4627.514111018329, 4630.560096790799, 4651.348811166439, 4685.789139488731, 4735.73953432561, 5200.167973124282, 5204.609654275944, 5204.687718736888, 5205.427402985669, 5217.373915130171, 5213.817516386908, 5219.399769026572, 5223.190405487156, 5225.5035771602015, 5280.419153893069, 4662.743549104764, 4743.1225223333795, 4770.522947705202, 4785.1625965455905, 4867.9269810952865, 5247.239150323182, 5255.39562950258, 5260.368755749258, 5320.441353657888, 5321.680699158062, 5099.515546023122, 5103.234514822732, 5109.310243117132, 5111.693298402108, 5129.487051294841, 5149.201873709581, 5156.2523434102595, 5200.97399513, 5221.869453263699, 5237.869053273698, 5118.309028281209, 5137.51193636604, 5147.819826306061, 5156.303898973665, 5174.611904107207, 4951.876203094879, 5043.142665746832, 5148.510891465305, 5159.355080614923, 5160.432352441228, 4357.542458041923, 4384.758838263862, 4391.209582275221, 4405.140997505519, 4429.313456414261, 3855.1133239354544, 3863.2273545291055, 3906.8437262509183, 3912.315344814646, 3927.5286965563746, 4334.501532323823, 4436.0462500562535, 4444.488883778342, 4473.261911784519, 4526.932096018562, 4970.652054356233, 5032.0, 5110.565601923878, 5131.076406246912, 5207.3490813648295, 4423.424954755926, 4426.579474949875, 4440.378347031418, 4442.755648439367, 4485.955140448554, 4572.839950601713, 4629.120467111238, 4629.77311012582, 4647.09381670571, 4695.600873925686, 4786.784594693317, 4797.304390863305, 4803.207470767285, 4836.879078023077, 4842.201036828884, 5090.669106508065, 5149.87125321855, 5179.81870634526, 5181.06740786662, 5186.092433824141, 4659.068186362673, 4742.66801323904, 4759.214729569582, 4801.639877009308, 4856.1016212000895, 5083.433640164015, 5097.592192624656, 5108.719020453911, 5112.642115051911, 5142.562882154909, 5184.429712731521, 5186.792528298825, 5189.662671926313, 5190.844274671766, 5191.896162076813, 4874.122657921608, 4944.653874228769, 4967.0, 4977.402711674622, 4997.2504124380175, 4969.900601988013, 5004.724740139181, 5008.474110218521, 5017.42299635532, 5073.949260507347, 4752.405949256343, 4923.310736496965, 4947.1589829729755, 4950.257461380822, 4961.404631444249, 4951.678140920829, 4959.107360675113, 4983.725895075806, 4992.151334273255, 4998.2502624606595, 4822.662413631012, 4835.516448355277, 4855.684380515255, 4864.27035944597, 4909.77905994224], "value": 4687.713010518536, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.666883214232, 619.4177473175215, 622.8131560531839, 623.990640140398, 656.5371413153728, 36169.27661446773, 37050.0, 39703.60296397035, 39738.403923941165, 39847.80076099623, 39863.80068099655, 40569.0, 40774.388384174265, 41019.794901025525, 41090.794546027304, 7722.382209423233, 7862.410319226053, 7875.251851074138, 7921.247481489249, 7926.405519586026, 7749.186335434782, 7884.250996155356, 7932.20677932205, 7940.801479962989, 7949.602519874012, 7876.488028278172, 7897.131315555284, 7922.881156782653, 7930.881036784453, 7972.3622110231045, 7846.843063138734, 7857.567833769141, 7862.960685196537, 7915.485493442908, 7917.841643167162, 7764.534127952341, 7838.8432231355055, 7851.528908265523, 7861.174576669482, 7862.331701805353, 36660.266794663956, 36797.63202367969, 36906.26187476236, 36912.815435922916, 36928.0, 2486.5151295497385, 2962.9259268518244, 3296.192432853942, 3300.290437555937, 3376.932461350784, 29516.26209344762, 29547.70452295471, 29834.95577654772, 29899.850500747576, 29952.550711739343, 3339.916502087443, 3409.9829500852584, 3443.776154549946, 3475.079104037432, 3511.0, 231942.0, 232363.0, 232598.9999999983, 233261.0, 234207.0, 32081.35837283288, 35127.82436087854, 35157.29685406278, 35184.0, 35307.11732206664, 31947.840260798548, 32487.675123248937, 32510.0, 32577.0, 32718.83640581782, 14466.638334041523, 14492.420303187755, 14671.486497972519, 14722.779158312635, 14727.705445891022, 11758.58844940423, 11816.586419475278, 11821.290722556674, 11873.228240164362, 11960.521579136912, 8361.95819020901, 8477.321814254845, 8494.320454363637, 8506.31949444043, 8568.52873091986, 3274.1650879025697, 3280.4423248047888, 3284.080457471912, 3315.751318651111, 3342.4317865962844, 919.7470695558775, 956.5552018311519, 958.6165533786402, 1064.505005172583, 1106.8893110689028, 29968.100956971324, 30069.097927062223, 30169.245768855515, 30303.848480757457, 30529.23676908095, 958.1903291718487, 1046.4715318763976, 1050.8528805967171, 1056.857324261215, 1060.183658582887, 14997.625059373384, 15055.171965542, 15283.694326113415, 15609.063456192438, 15714.0, 357533.0, 676038.0, 686392.0, 693577.0, 694219.0, 54236.45763542393, 54540.0, 54909.0, 55090.449095508535, 55318.17022744662, 1316.5984374765787, 1329.2157627000117, 1337.097459215026, 1352.1819299323963, 1355.5052405871786, 29492.115236542937, 30648.693513065475, 30802.537961930142, 31023.0, 31266.843665781525, 46012.53987460083, 46579.06841863076, 46651.76674116608, 46833.297500536835, 46942.76528617335, 356364.0, 363477.0, 364128.0, 365890.0, 366151.0, 26971.190864274104, 27091.59362609602, 27098.0, 27228.31929201786, 27289.727102728717, 44941.77529112333, 45749.0, 46467.0, 46734.76632616815, 46823.29765053595, 38488.123101438505, 39213.0, 39329.60670393259, 40150.0, 40631.39052914149, 38572.42141367938, 38580.421293680054, 39626.2074758509, 39950.40074398944, 40314.0, 33402.33195336128, 38075.42886856755, 39003.41494877522, 39065.414018789175, 39150.2169956605, 32529.34941301208, 34913.8254308737, 35333.29333413369, 35418.29163416666, 35722.285554288246, 26098.73901261039, 26608.733912660624, 26802.731972680023, 26837.86581067082, 27157.86421067882], "value": 17258.95108399012, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.4612131591167, 379.7038310118108, 382.5103867050175, 385.6644719094388, 391.2429449016156, 16355.264013119424, 16501.257443415045, 17228.569285767862, 17466.03936783478, 17471.650566988654, 12278.263304201753, 15408.614784630361, 15839.445619403323, 15883.0, 16514.256858441368, 4705.082508910764, 4827.686200396981, 4879.853604391857, 4881.0, 4894.902101957959, 3465.618781933998, 5256.684598924057, 5564.443555644423, 5573.665580065189, 5606.467385598362, 5621.325440947092, 5631.521320687726, 5635.802746903859, 5639.210510528529, 5657.462541058593, 5969.253843269591, 6044.365341639131, 6085.087236914454, 6116.510679145657, 6128.417800308964, 4699.224627936386, 5011.899762004776, 5417.160340147283, 5424.701641409721, 5425.701586412746, 12237.082218833622, 12349.93825030869, 12552.874471255262, 12673.112882098258, 12703.618891433272, 1914.1099388784282, 1927.4603111128906, 1940.631280056799, 2015.3147929703825, 2027.9898600506904, 9382.390144640576, 9690.273229507744, 9964.352317099365, 10957.452127393599, 13857.514986975508, 1719.2693105430142, 1797.074506629087, 1803.7925638551603, 1805.0, 1844.8431883289936, 64683.0, 67844.3215567843, 68642.0, 68918.65540672315, 69771.30228697699, 10156.339837910513, 10185.388876667275, 10400.791984160425, 10502.0, 10600.310979786289, 14299.142051476945, 14366.209858457885, 14390.208538530482, 14399.208043557495, 14426.567202983928, 7481.625918704043, 7774.6890124394395, 7777.066751989684, 7853.253940875607, 7905.249001344863, 7261.41908647307, 7348.0, 7471.551706897603, 7510.586917719578, 7526.774196774106, 4272.316429371285, 4410.757408342508, 4469.4860091089295, 4519.909601807945, 4551.4765801932535, 1620.8622267107428, 1781.2251670523106, 1908.8472922166193, 1913.4451009207453, 1926.3546711851407, 789.2856964447185, 942.1661829280998, 978.6770365779275, 981.254246772458, 1031.9122874555746, 16019.279132439067, 16491.5877103071, 16742.162891855358, 17017.91491042537, 17089.06010169428, 869.9565021748887, 932.4964519159578, 934.7149119518613, 986.7187851462298, 993.9353941993747, 9431.76420589477, 9484.0, 9593.184579310697, 9658.77848094942, 9738.269629777795, 380532.0, 388788.0, 391907.0, 392095.0, 394030.0, 78487.60756196182, 78720.6063969688, 79994.0, 80144.0, 80419.59790201012, 936.7377134402378, 957.5738796235609, 975.8341082016216, 992.1665800727424, 996.8355221388534, 14802.851971480148, 14952.775708364166, 15036.924815375853, 15245.923770381078, 15256.618584535476, 26874.596881046407, 29041.854790725913, 34828.303433930676, 34831.30337393289, 35716.0, 44665.33002005037, 47362.289565655854, 47420.52579474299, 53569.73215133899, 54169.45830541644, 7585.848283034198, 7660.425468089804, 7676.078870535572, 7723.420743444377, 7730.806729831799, 9973.401595904268, 11907.46416411281, 12024.579139730067, 12037.939810301243, 12330.63008109758, 10322.690319290434, 10507.684769456928, 10511.369317840954, 10572.207084468542, 10890.128789696964, 10369.63706270277, 10590.152787777113, 10667.946660266649, 10746.355218686904, 10787.0, 10662.8400573993, 10883.510242038968, 10979.890201097887, 11041.889581104086, 11066.0, 7804.765857024298, 7837.804054898673, 7925.484843485386, 8006.719764808204, 8093.919060809317, 7948.8807667883875, 9768.80462390734, 10853.837192441963, 10965.122790176607, 11116.61091861781], "value": 8227.788351900048, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.0800711565946, 1534.0872181052273, 1712.6232228909644, 1822.5625849796054, 1830.5881176735245, 6673.132492775932, 7319.670614822332, 7438.0, 7844.215578442153, 7888.0, 7502.849943001151, 7636.198199189089, 7668.194839541851, 7718.421118416113, 7737.806554836132, 2140.090461553841, 2164.6861205125247, 2165.631842586756, 2166.555856049506, 2179.9455013624706, 2180.7928246816605, 2209.635410157322, 2228.6211344071467, 2239.7984181423667, 2242.495438526327, 2125.0543508138885, 2126.734158230221, 2139.1336508713994, 2182.7053347798083, 2259.0850705464313, 2139.272647299918, 2143.8928053597338, 2148.581026699794, 2151.9784802151935, 2153.536989547255, 2094.5915546468445, 2149.365937048559, 2168.1002384010617, 2176.3906106290265, 2185.715856938604, 7648.655810488542, 7655.961720191363, 7681.846363072707, 7684.193159718261, 7716.035495563055, 4300.118475712503, 4360.106178233486, 4470.061287129706, 4470.41884555009, 4472.82108715651, 2760.3375189954468, 2784.484870299001, 2848.344880677456, 2855.34327104765, 2856.371598248382, 931.0735817861204, 946.7396465971844, 1617.8382161783845, 1800.97298540522, 1832.8167183281698, 9966.601335946625, 10043.548040338203, 10061.39631622105, 10077.042680945298, 10099.0910818026, 3919.1573811630637, 3954.9209015820097, 3959.4654721612214, 4036.233115708065, 4080.7959602019782, 8128.227818357246, 8167.83664326722, 8196.877046844302, 8201.630926608317, 8227.794305142419, 4451.221036318696, 4491.887702807456, 4497.168023915586, 4501.144782491317, 4506.909861802746, 3702.777833330009, 3894.6689531389584, 4029.738067025634, 4140.91718165635, 4153.68847336451, 3457.187560923181, 3483.0, 3537.2748586539697, 3576.409892367782, 3599.460080987873, 1058.0424715632364, 1058.1270451877233, 1065.8507808906759, 1077.06833588945, 1082.0477979378097, 878.3939082033377, 912.3157631776168, 913.159892898535, 927.9211267042242, 930.5951910918772, 5311.787528498894, 5329.440408757102, 5354.759035843396, 5399.70301633414, 5401.5948803839865, 885.2165833237631, 938.8169306985072, 959.1703176752059, 1003.2926786615419, 1003.5584342889106, 3593.7125029997537, 3717.7955212463035, 3725.795081270502, 3729.5710993236125, 3748.9625103748613, 9164.258790829721, 9301.767455813659, 9306.06939306064, 9338.626454941726, 9440.24478041755, 9267.397619154868, 9292.814143717087, 9333.393329433566, 9339.439633622005, 9340.4862732549, 6707.899381509281, 7074.22183559808, 7109.644517774194, 7128.6435678215885, 7236.891446628305, 5108.463611320906, 5276.314079169683, 5372.838814835562, 5411.675299482044, 5447.073997420369, 8563.657453701782, 8722.127787221227, 8763.780905477413, 8794.944606647243, 8850.291976641724, 8651.134886511298, 8917.10828917103, 8917.821643567222, 8929.374943753875, 9018.774530636787, 5799.9130013049, 6390.201224846895, 6451.0645956337, 6560.868782624416, 6670.433013193933, 7353.6690848912995, 7375.188729239672, 7445.367143792838, 7455.962720186364, 7484.43866709988, 6607.0, 6634.966825165843, 6642.800715978528, 6728.125343705287, 6736.225334086446, 6635.63504007265, 6674.466042716474, 6716.731330746716, 6783.728650853911, 6810.62541560219, 6295.401936815995, 6383.457406120532, 6408.070829729756, 6433.13152724395, 6435.678216089271, 4560.3843481129625, 4609.124266389375, 4611.2852507861335, 4710.9764451177525, 4792.880177995578, 4645.187092258773, 4688.132695451216, 4776.140294746979, 4786.018866132504, 4841.298011788342], "value": 4153.590699243409, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.6785641148589, 314.6255955413058, 314.78909130882306, 315.83892214970365, 317.9157523256336, 4702.976485117578, 4917.582005529534, 4949.604031677466, 5018.515834661843, 5033.974830125853, 4690.273007683806, 4878.195097808857, 4890.633202509817, 4919.212925931852, 4927.5072492750705, 3916.5887581803786, 3939.4287828264883, 3941.783201923893, 3962.286788378091, 3962.5140572285395, 3660.469231961364, 3907.804609769514, 3918.921621567567, 3930.842766289345, 3949.842006319758, 3801.714871384643, 3809.866654667087, 3831.7700937943673, 3833.5208098987628, 3840.577536470986, 3810.637989391017, 3815.4086116651965, 3820.102275965146, 3837.2901013312485, 3862.671672907806, 3370.3090866372336, 3389.3390788796196, 3410.471376936579, 3412.8293585320885, 3417.419038763391, 4623.583877451046, 4678.836240731558, 4695.225287827504, 4708.434987801452, 4769.809207631691, 4295.656347492224, 4336.696431249814, 4398.164348773723, 4400.977995110036, 4412.3160910059, 5093.898122037575, 5121.8719532012, 5122.667026643257, 5128.179491281415, 5145.665531740425, 3616.0959760059986, 3644.4511082789973, 3696.482492451059, 3698.223373091654, 3700.112942399369, 5353.571714262888, 5387.488188622075, 5390.299261096072, 5395.244665746799, 5420.430854760233, 3764.604716504782, 3783.8297276622066, 3795.7532760370486, 3801.6008319126095, 3815.1606646537716, 3794.3359912015285, 3823.667562786698, 3825.3305671507374, 3831.080540670219, 3835.5972622874756, 4032.536258330271, 4304.16068866568, 4323.805428755713, 4337.327714204303, 4375.146846364992, 5181.171012638035, 5198.428172900978, 5210.452902445264, 5211.7915283389, 5212.0, 1208.905940124189, 1264.2161859647078, 1285.7364240330896, 1288.368699337318, 1288.4731593062063, 861.9482831030158, 874.8119154381839, 875.9824803503894, 876.7238319929202, 879.4723166100289, 4390.692651514427, 4407.250767369491, 4416.492103408085, 4417.779111044435, 4430.401895744098, 5158.6131040171385, 5164.546840250926, 5192.61055420845, 5193.533071790869, 5197.324347834833, 4375.365571992043, 4441.356003379492, 4454.354118652777, 4455.309427038814, 4456.688031837805, 2615.0, 2750.752432281104, 2780.541210700252, 2783.7355451232506, 2785.818921770119, 4877.073356062337, 4882.829100981519, 4892.241702536041, 4899.485554016777, 4970.751462426864, 5226.738663066832, 5296.92054619181, 5313.760880760375, 5344.518993290622, 5386.165144402624, 5002.799888004512, 5014.648974571745, 5023.949760502422, 5030.339987804015, 5044.873878153076, 5390.407055224001, 5420.0, 5435.130379139318, 5449.509544140888, 5463.098588732814, 5200.349956255468, 5233.162693968947, 5237.659552129099, 5312.814051508179, 5328.4671532846405, 4967.254911763264, 5003.524665156804, 5015.0, 5015.442124516596, 5023.547880690755, 3697.8705745298785, 3706.814659266972, 3737.7757334560015, 3754.6433088856515, 3772.2078363542864, 5125.769340379767, 5358.705271210121, 5426.565874729933, 5435.945640543702, 5448.754806033818, 5195.636305458582, 5216.843494695014, 5237.590708274237, 5248.343957005374, 5277.313949186735, 5182.367554220408, 5235.267062611161, 5239.82104026591, 5243.265942768092, 5252.711100889488, 4793.304970779287, 5113.386393632788, 5127.2052831811125, 5136.434992150786, 5164.251183578435, 5181.715005674573, 5206.589683757145, 5208.661437006734, 5226.790928362823, 5268.604854635994, 5080.618953578422, 5110.872228194325, 5117.925235700544, 5140.485951404829, 5145.61407894402], "value": 3884.36492006535, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.9460040496961, 736.4881407421838, 745.2547452547452, 786.5713186313459, 822.3708862720018, 11825.113116516264, 12672.0, 12679.556215532459, 12682.0, 12725.809112863315, 12643.0, 12672.112952093334, 12682.80975785364, 12683.809742853842, 12735.490580376798, 671.7145213284359, 823.9093699693029, 849.413904405961, 853.5134973065356, 855.9400841941067, 853.8804567360575, 856.4133568505563, 859.072202021815, 862.2024627219797, 864.1617630898019, 921.2952091649893, 922.6032805893464, 922.7693076730817, 922.9630814767402, 925.8611208318772, 908.68650315641, 911.011552465569, 912.2382810353363, 912.4388501071826, 913.7213149989251, 677.1062197898775, 677.5697432130584, 678.0236459498307, 678.3216783216783, 678.5792808458738, 12941.48234070636, 12965.22208667483, 12967.351632418342, 13035.543755968496, 13045.673858153526, 12884.291363974977, 12965.675858103528, 13018.15382000167, 13050.673733156747, 13119.409626566732, 10130.898691013143, 10194.235432342604, 10219.335743176744, 10265.794684106351, 10388.79222415555, 3385.779924304912, 3410.07927859479, 3473.826308684581, 3474.3051389722154, 3481.1819222482695, 42975.0, 43011.784941075406, 43089.56910430887, 43240.0, 44761.32858007165, 10171.084602385672, 10360.0, 10410.115140213014, 10431.321964072311, 10451.850296467383, 18188.1815318311, 18271.725924110884, 18279.54301142482, 18281.3601523946, 18431.26274949014, 6720.126383570202, 6889.965550172217, 6915.723371065202, 6928.0, 7149.82125446868, 3755.3991361382596, 3761.3229618668356, 3773.5471743390967, 3838.136419305634, 3901.0637447012514, 2827.3214428537003, 2957.3937342844665, 2958.1717119206655, 2966.8664910079096, 2967.451021561018, 526.507715286201, 539.3016044222662, 543.8341305901658, 544.083219774681, 552.5579536370967, 584.9181114643953, 596.9970150149309, 601.5668718522656, 611.1382950040422, 618.4588485075559, 7385.926140738631, 7399.7040118395735, 7632.618369081523, 7667.463277570517, 7737.806554836174, 526.8340472751071, 541.3449725831788, 574.2764117212259, 589.9675517846559, 648.2739331948154, 3712.3317802795755, 3848.592944906868, 3937.3897045957924, 3953.3872249801325, 4096.487939007624, 52302.73848630809, 53152.202716958505, 53358.733206333716, 54502.0, 54786.45213547813, 46748.76625616918, 48681.756591216814, 48984.0, 49253.50746492489, 49554.0, 43407.348889766676, 44927.0, 45706.31440528395, 46174.0, 46179.30731039037, 7900.802479938047, 7988.560629165451, 8275.0, 8424.747257582283, 8625.482471051757, 29775.851120744257, 29813.5527967085, 30217.09348719542, 30246.243843903198, 30320.241993950327, 39109.804450977565, 39391.212175755754, 39561.81314560568, 40114.79942600268, 40188.397174043, 10295.485225738832, 10470.371777693363, 10633.308834925705, 10936.726581835517, 11355.829662555234, 12191.390430478617, 12245.14284000147, 12322.0, 12639.747205056032, 13039.348032598522, 10885.346879187275, 11297.887021130013, 11393.487293071666, 11948.223365481215, 12037.819432708342, 11372.715682108013, 11634.185607007428, 11969.042476602026, 12101.757964840477, 12368.81446778317, 9906.603735850773, 10443.164546836082, 10605.41670208146, 10859.185561083108, 11643.76712465729, 8968.327375446737, 8975.0, 8996.86504702443, 9247.491387973727, 9323.487208203615, 8795.47227166372, 9155.359124861196, 9216.30877684163, 9282.21101206405, 9411.29415293842], "value": 6106.91649728151, "unit": "score"}], "name": "dromaeo_css", "value": 6350.559571211498, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 103.0, 112.0, 113.0, 113.0, 107.0, 113.0, 115.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 136.0, 165.0, 192.0, 132.0, 162.0, 162.0, 131.0, 187.0, 132.0], "value": 155.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 164.0, 165.0, 163.0, 162.0, 160.0, 164.0, 160.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 153.0, 77.0, 78.0, 75.0, 76.0, 153.0, 75.0], "value": 91.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 151.0, 93.0, 94.0, 92.0, 147.0, 94.0, 93.0, 140.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 154.0, 148.0, 147.0, 149.0, 148.0, 147.0, 146.0, 146.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 67.0, 70.0, 67.0, 85.0, 66.0, 65.0], "value": 68.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 73.0, 63.0, 64.0, 63.0, 64.0, 63.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 89.0, 83.0, 83.0, 84.0, 86.0, 89.0, 83.0, 84.0, 87.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 134.0, 142.0, 131.0, 134.0, 131.0, 133.0, 148.0, 228.0, 149.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 179.0, 176.0, 178.0, 172.0, 173.0, 177.0, 175.0, 175.0, 169.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 70.0, 66.0, 67.0, 67.0, 67.0, 74.0, 74.0, 68.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1600.5, "alertThreshold": 2.0}]} 07:48:43 INFO - Return code: 0 07:48:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:48:43 ERROR - # TBPL SUCCESS # 07:48:43 INFO - Running post-action listener: _resource_record_post_action 07:48:43 INFO - ##### 07:48:43 INFO - ##### Finished run-tests step (success) 07:48:43 INFO - ##### 07:48:43 INFO - Running post-run listener: _resource_record_post_run 07:48:44 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283336704; Read time: 12; Write time: 203140 07:48:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1462272; Read time: 0; Write time: 44 07:48:44 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281874432; Read time: 12; Write time: 203096 07:48:44 INFO - Running post-run listener: _upload_blobber_files 07:48:44 INFO - Blob upload gear active. 07:48:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:48:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:48:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:48:44 INFO - (blobuploader) - INFO - Open directory for files ... 07:48:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:48:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:48:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:45 INFO - (blobuploader) - INFO - Done attempting. 07:48:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:48:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:48:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:46 INFO - (blobuploader) - INFO - Done attempting. 07:48:46 INFO - (blobuploader) - INFO - Iteration through files over. 07:48:46 INFO - Return code: 0 07:48:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:48:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:48:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/607d1a498ee4d13cdac4dfd50ca564d72c482ad83d7a189ff5bad899eacd5bdf863636a62b8ec542f3fee700a554ba781a726e273fa0794ef8087a0dfc1a22dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/719347ec0c6a5b71affa27fe2e2764c5e53b9e649a9e85a46f23cee559d9625878371a6adc8b1e13d60e2216fab671269caab694c422a10a2a2de1991a447349"} 07:48:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:48:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:48:46 INFO - Contents: 07:48:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/607d1a498ee4d13cdac4dfd50ca564d72c482ad83d7a189ff5bad899eacd5bdf863636a62b8ec542f3fee700a554ba781a726e273fa0794ef8087a0dfc1a22dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/719347ec0c6a5b71affa27fe2e2764c5e53b9e649a9e85a46f23cee559d9625878371a6adc8b1e13d60e2216fab671269caab694c422a10a2a2de1991a447349"} 07:48:46 INFO - Running post-run listener: copy_logs_to_upload_dir 07:48:46 INFO - Copying logs to upload dir... 07:48:46 INFO - mkdir: /builds/slave/test/build/upload/logs 07:48:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.242364 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-06 07:48:46.487163) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 07:48:46.490942) ========= 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=ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368 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/607d1a498ee4d13cdac4dfd50ca564d72c482ad83d7a189ff5bad899eacd5bdf863636a62b8ec542f3fee700a554ba781a726e273fa0794ef8087a0dfc1a22dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/719347ec0c6a5b71affa27fe2e2764c5e53b9e649a9e85a46f23cee559d9625878371a6adc8b1e13d60e2216fab671269caab694c422a10a2a2de1991a447349"} build_url:https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/SwBFSx1yQLaItQo63ipcIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/607d1a498ee4d13cdac4dfd50ca564d72c482ad83d7a189ff5bad899eacd5bdf863636a62b8ec542f3fee700a554ba781a726e273fa0794ef8087a0dfc1a22dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/719347ec0c6a5b71affa27fe2e2764c5e53b9e649a9e85a46f23cee559d9625878371a6adc8b1e13d60e2216fab671269caab694c422a10a2a2de1991a447349"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 07:48:46.518832) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:48:46.519166) ========= 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=ed14279e38b05397cf4aa391000001a4-1462544877.805246-1492201368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:48:46.599410) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 07:48:46.602812) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 07:48:46.603125) ========= ========= Total master_lag: 0.17 =========