builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1461686673.1 results: success (0) buildid: 20160426084505 builduid: 46315ec6ce654b83806a3efe3d009eb5 revision: 5ffdd1bafd496a5e9ca0d32f9729333d1b467eb4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 09:04:33.101872) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 09:04:33.102504) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 09:04:33.102767) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 09:04:33.120902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 09:04:33.121507) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 09:04:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.1K=0.2s 2016-04-26 09:04:33 (58.1 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.296266 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 09:04:33.431617) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 09:04:33.431942) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016983 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 09:04:33.481528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 09:04:33.481891) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5ffdd1bafd496a5e9ca0d32f9729333d1b467eb4 --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 5ffdd1bafd496a5e9ca0d32f9729333d1b467eb4 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 09:04:33,831 truncating revision to first 12 chars 2016-04-26 09:04:33,831 Setting DEBUG logging. 2016-04-26 09:04:33,831 attempt 1/10 2016-04-26 09:04:33,831 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5ffdd1bafd49?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 09:04:34,224 unpacking tar archive at: fx-team-5ffdd1bafd49/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673845 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 09:04:34.172455) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 09:04:34.172773) ========= script_repo_revision: 5ffdd1bafd496a5e9ca0d32f9729333d1b467eb4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 09:04:34.173166) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 09:04:34.173427) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 09:04:34.182377) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-26 09:04:34.182659) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:04:34 INFO - MultiFileLogger online at 20160426 09:04:34 in /builds/slave/test 09:04:34 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 09:04:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:04:34 INFO - {'append_to_log': False, 09:04:34 INFO - 'base_work_dir': '/builds/slave/test', 09:04:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:04:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:04:34 INFO - 'branch': 'Fx-Team-Non-PGO', 09:04:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:04:34 INFO - 'config_files': ('talos/linux_config.py',), 09:04:34 INFO - 'default_actions': ('clobber', 09:04:34 INFO - 'read-buildbot-config', 09:04:34 INFO - 'download-and-extract', 09:04:34 INFO - 'populate-webroot', 09:04:34 INFO - 'create-virtualenv', 09:04:34 INFO - 'install', 09:04:34 INFO - 'run-tests'), 09:04:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:04:34 INFO - 'download_minidump_stackwalk': True, 09:04:34 INFO - 'download_symbols': 'ondemand', 09:04:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:04:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:04:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:04:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:04:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:04:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:04:34 INFO - 'installer_path': 'installer.exe', 09:04:34 INFO - 'log_level': 'info', 09:04:34 INFO - 'log_name': 'talos', 09:04:34 INFO - 'log_to_console': True, 09:04:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:04:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:04:34 INFO - 'opt_config_files': (), 09:04:34 INFO - 'pip_index': False, 09:04:34 INFO - 'sps_profile': False, 09:04:34 INFO - 'sps_profile_interval': 0, 09:04:34 INFO - 'suite': 'dromaeojs-e10s', 09:04:34 INFO - 'system_bits': '32', 09:04:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:04:34 INFO - 'title': 'talos-linux64-ix-051', 09:04:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:04:34 INFO - 'use_talos_json': True, 09:04:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:04:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:04:34 INFO - 'work_dir': 'build'} 09:04:34 INFO - ##### 09:04:34 INFO - ##### Running clobber step. 09:04:34 INFO - ##### 09:04:34 INFO - Running pre-action listener: _resource_record_pre_action 09:04:34 INFO - Running main action method: clobber 09:04:34 INFO - rmtree: /builds/slave/test/build 09:04:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:04:35 INFO - Running post-action listener: _resource_record_post_action 09:04:35 INFO - ##### 09:04:35 INFO - ##### Running read-buildbot-config step. 09:04:35 INFO - ##### 09:04:35 INFO - Running pre-action listener: _resource_record_pre_action 09:04:35 INFO - Running main action method: read_buildbot_config 09:04:35 INFO - Using buildbot properties: 09:04:35 INFO - { 09:04:35 INFO - "project": "", 09:04:35 INFO - "product": "firefox", 09:04:35 INFO - "script_repo_revision": "production", 09:04:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:04:35 INFO - "repository": "", 09:04:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:04:35 INFO - "buildid": "20160426084505", 09:04:35 INFO - "pgo_build": "False", 09:04:35 INFO - "basedir": "/builds/slave/test", 09:04:35 INFO - "buildnumber": 1215, 09:04:35 INFO - "slavename": "talos-linux64-ix-051", 09:04:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:04:35 INFO - "platform": "ubuntu64_hw", 09:04:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:04:35 INFO - "branch": "fx-team", 09:04:35 INFO - "repo_path": "integration/fx-team", 09:04:35 INFO - "revision": "5ffdd1bafd496a5e9ca0d32f9729333d1b467eb4", 09:04:35 INFO - "stage_platform": "linux64", 09:04:35 INFO - "builduid": "46315ec6ce654b83806a3efe3d009eb5", 09:04:35 INFO - "slavebuilddir": "test" 09:04:35 INFO - } 09:04:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 09:04:35 INFO - Running post-action listener: _resource_record_post_action 09:04:35 INFO - ##### 09:04:35 INFO - ##### Running download-and-extract step. 09:04:35 INFO - ##### 09:04:35 INFO - Running pre-action listener: _resource_record_pre_action 09:04:35 INFO - Running main action method: download_and_extract 09:04:35 INFO - mkdir: /builds/slave/test/build/tests 09:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:35 INFO - https://queue.taskcluster.net/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:04:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:04:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:04:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/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 09:04:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/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 09:04:36 INFO - Downloaded 1361 bytes. 09:04:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:04:36 INFO - Using the following test package requirements: 09:04:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:04:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:04:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:04:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:36 INFO - u'jsshell-linux-x86_64.zip'], 09:04:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:04:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:04:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:04:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:04:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:04:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:04:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:04:36 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')]} 09:04:36 INFO - https://queue.taskcluster.net/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:04:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/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 09:04:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/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 09:04:37 INFO - Downloaded 22291517 bytes. 09:04:37 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'] 09:04:37 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 09:04:39 INFO - Return code: 0 09:04:39 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 09:04:39 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')]} 09:04:39 INFO - https://queue.taskcluster.net/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:04:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/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 09:04:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/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 09:04:40 INFO - Downloaded 22291517 bytes. 09:04:40 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'] 09:04:40 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 09:04:42 INFO - Return code: 0 09:04:42 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')]} 09:04:42 INFO - https://queue.taskcluster.net/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:04:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:04:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:04:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/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 09:04:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/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 09:04:43 INFO - Downloaded 10840145 bytes. 09:04:43 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'] 09:04:43 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 09:04:44 INFO - Return code: 0 09:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:44 INFO - https://queue.taskcluster.net/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:04:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:04:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:04:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/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 09:04:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/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 09:04:46 INFO - Downloaded 54813220 bytes. 09:04:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:04:46 INFO - mkdir: /builds/slave/test/properties 09:04:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:04:46 INFO - Writing to file /builds/slave/test/properties/build_url 09:04:46 INFO - Contents: 09:04:46 INFO - build_url:https://queue.taskcluster.net/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:04:46 INFO - Running post-action listener: _resource_record_post_action 09:04:46 INFO - Running post-action listener: set_extra_try_arguments 09:04:46 INFO - ##### 09:04:46 INFO - ##### Running populate-webroot step. 09:04:46 INFO - ##### 09:04:46 INFO - Running pre-action listener: _resource_record_pre_action 09:04:46 INFO - Running main action method: populate_webroot 09:04:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:04:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:04:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:04:46 INFO - '--tppagecycles', 09:04:46 INFO - '7'], 09:04:46 INFO - 'tests': ['tsvgm']}}, 09:04:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:04:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:04:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:04:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:04:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:04:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:04:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:46 INFO - 'talos_options': ['--disable-e10s'], 09:04:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:46 INFO - 'talos_options': ['--disable-e10s'], 09:04:46 INFO - 'tests': ['damp', 'tps']}, 09:04:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:46 INFO - 'tests': ['damp', 'tps']}, 09:04:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:04:46 INFO - 'tests': ['dromaeo_dom']}, 09:04:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:04:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:04:46 INFO - 'tests': ['a11yr', 09:04:46 INFO - 'ts_paint', 09:04:46 INFO - 'tpaint', 09:04:46 INFO - 'sessionrestore', 09:04:46 INFO - 'sessionrestore_no_auto_restore', 09:04:46 INFO - 'tabpaint']}, 09:04:46 INFO - 'other-e10s': {'tests': ['a11yr', 09:04:46 INFO - 'ts_paint', 09:04:46 INFO - 'tpaint', 09:04:46 INFO - 'sessionrestore', 09:04:46 INFO - 'sessionrestore_no_auto_restore', 09:04:46 INFO - 'tabpaint']}, 09:04:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:04:46 INFO - 'ts_paint', 09:04:46 INFO - 'tpaint', 09:04:46 INFO - 'sessionrestore', 09:04:46 INFO - 'sessionrestore_no_auto_restore', 09:04:46 INFO - 'tabpaint']}, 09:04:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:04:46 INFO - 'ts_paint', 09:04:46 INFO - 'tpaint', 09:04:46 INFO - 'sessionrestore', 09:04:46 INFO - 'sessionrestore_no_auto_restore', 09:04:46 INFO - 'tabpaint']}, 09:04:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:04:46 INFO - 'tests': ['a11yr', 09:04:46 INFO - 'ts_paint', 09:04:46 INFO - 'tpaint', 09:04:46 INFO - 'sessionrestore', 09:04:46 INFO - 'sessionrestore_no_auto_restore', 09:04:46 INFO - 'tabpaint']}, 09:04:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:04:46 INFO - 'tests': ['a11yr', 09:04:46 INFO - 'ts_paint', 09:04:46 INFO - 'tpaint', 09:04:46 INFO - 'sessionrestore', 09:04:46 INFO - 'sessionrestore_no_auto_restore', 09:04:46 INFO - 'tabpaint']}, 09:04:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:04:46 INFO - 'tests': ['tsvgx', 09:04:46 INFO - 'tsvgr_opacity', 09:04:46 INFO - 'tart', 09:04:46 INFO - 'tscrollx', 09:04:46 INFO - 'cart']}, 09:04:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:04:46 INFO - 'tsvgr_opacity', 09:04:46 INFO - 'tart', 09:04:46 INFO - 'tscrollx', 09:04:46 INFO - 'cart']}, 09:04:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:46 INFO - 'talos_options': ['--disable-e10s'], 09:04:46 INFO - 'tests': ['tp5o']}, 09:04:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:46 INFO - 'tests': ['tp5o']}, 09:04:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:46 INFO - 'talos_options': ['--disable-e10s', 09:04:46 INFO - '--xperf_path', 09:04:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:46 INFO - 'tests': ['tp5n']}, 09:04:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:46 INFO - 'talos_options': ['--xperf_path', 09:04:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:46 INFO - 'tests': ['tp5n']}}, 09:04:46 INFO - 'talos.zip': {'path': '', 09:04:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:04:46 INFO - Running post-action listener: _resource_record_post_action 09:04:46 INFO - ##### 09:04:46 INFO - ##### Running create-virtualenv step. 09:04:46 INFO - ##### 09:04:46 INFO - Running pre-action listener: _resource_record_pre_action 09:04:46 INFO - Running main action method: create_virtualenv 09:04:46 INFO - Creating virtualenv /builds/slave/test/build/venv 09:04:46 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 09:04:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:04:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:04:47 INFO - Using real prefix '/usr' 09:04:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:04:47 INFO - Installing distribute.............................................................................................................................................................................................done. 09:04:49 INFO - Installing pip.................done. 09:04:49 INFO - Return code: 0 09:04:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:49 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 0x7f3c222e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf02410>, '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 0xf03310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf037a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', '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 09:04:49 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 09:04:49 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 09:04:49 INFO - Using env: {'DISPLAY': ':0', 09:04:49 INFO - 'HOME': '/home/cltbld', 09:04:49 INFO - 'LANG': 'en_US.UTF-8', 09:04:49 INFO - 'LANGUAGE': 'en_US:en', 09:04:49 INFO - 'LOGNAME': 'cltbld', 09:04:49 INFO - 'MAIL': '/var/mail/cltbld', 09:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:49 INFO - 'MOZ_NO_REMOTE': '1', 09:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:49 INFO - 'NO_EM_RESTART': '1', 09:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:49 INFO - 'PWD': '/builds/slave/test', 09:04:49 INFO - 'SHELL': '/bin/bash', 09:04:49 INFO - 'SHLVL': '1', 09:04:49 INFO - 'TERM': 'linux', 09:04:49 INFO - 'TMOUT': '86400', 09:04:49 INFO - 'USER': 'cltbld', 09:04:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', 09:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:49 INFO - '_': '/tools/buildbot/bin/python'} 09:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:49 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 09:04:49 INFO - Cleaning up... 09:04:49 INFO - Return code: 0 09:04:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:49 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 0x7f3c222e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf02410>, '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 0xf03310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf037a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', '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 09:04:49 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 09:04:49 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 09:04:49 INFO - Using env: {'DISPLAY': ':0', 09:04:49 INFO - 'HOME': '/home/cltbld', 09:04:49 INFO - 'LANG': 'en_US.UTF-8', 09:04:49 INFO - 'LANGUAGE': 'en_US:en', 09:04:49 INFO - 'LOGNAME': 'cltbld', 09:04:49 INFO - 'MAIL': '/var/mail/cltbld', 09:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:49 INFO - 'MOZ_NO_REMOTE': '1', 09:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:49 INFO - 'NO_EM_RESTART': '1', 09:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:49 INFO - 'PWD': '/builds/slave/test', 09:04:49 INFO - 'SHELL': '/bin/bash', 09:04:49 INFO - 'SHLVL': '1', 09:04:49 INFO - 'TERM': 'linux', 09:04:49 INFO - 'TMOUT': '86400', 09:04:49 INFO - 'USER': 'cltbld', 09:04:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', 09:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:49 INFO - '_': '/tools/buildbot/bin/python'} 09:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:49 INFO - Downloading/unpacking psutil>=0.7.1 09:04:49 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 09:04:49 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 09:04:49 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 09:04:49 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 09:04:49 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 09:04:49 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 09:04:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:04:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:51 INFO - Installing collected packages: psutil 09:04:51 INFO - Running setup.py install for psutil 09:04:51 INFO - building 'psutil._psutil_linux' extension 09:04:51 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 09:04:52 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 09:04:52 INFO - building 'psutil._psutil_posix' extension 09:04:52 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 09:04:52 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 09:04:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:52 INFO - Successfully installed psutil 09:04:52 INFO - Cleaning up... 09:04:52 INFO - Return code: 0 09:04:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:04:52 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')]} 09:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:52 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')]} 09:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:52 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 0x7f3c222e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf02410>, '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 0xf03310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf037a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', '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 09:04:52 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 09:04:52 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 09:04:52 INFO - Using env: {'DISPLAY': ':0', 09:04:52 INFO - 'HOME': '/home/cltbld', 09:04:52 INFO - 'LANG': 'en_US.UTF-8', 09:04:52 INFO - 'LANGUAGE': 'en_US:en', 09:04:52 INFO - 'LOGNAME': 'cltbld', 09:04:52 INFO - 'MAIL': '/var/mail/cltbld', 09:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:52 INFO - 'MOZ_NO_REMOTE': '1', 09:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:52 INFO - 'NO_EM_RESTART': '1', 09:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:52 INFO - 'PWD': '/builds/slave/test', 09:04:52 INFO - 'SHELL': '/bin/bash', 09:04:52 INFO - 'SHLVL': '1', 09:04:52 INFO - 'TERM': 'linux', 09:04:52 INFO - 'TMOUT': '86400', 09:04:52 INFO - 'USER': 'cltbld', 09:04:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', 09:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:52 INFO - '_': '/tools/buildbot/bin/python'} 09:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:04:52 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 09:04:52 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 09:04:52 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 09:04:52 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 09:04:52 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 09:04:52 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 09:04:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:04:54 INFO - Installing collected packages: mozsystemmonitor 09:04:54 INFO - Running setup.py install for mozsystemmonitor 09:04:54 INFO - Successfully installed mozsystemmonitor 09:04:54 INFO - Cleaning up... 09:04:54 INFO - Return code: 0 09:04:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:54 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 0x7f3c222e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf02410>, '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 0xf03310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf037a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', '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 09:04:54 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 09:04:54 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 09:04:54 INFO - Using env: {'DISPLAY': ':0', 09:04:54 INFO - 'HOME': '/home/cltbld', 09:04:54 INFO - 'LANG': 'en_US.UTF-8', 09:04:54 INFO - 'LANGUAGE': 'en_US:en', 09:04:54 INFO - 'LOGNAME': 'cltbld', 09:04:54 INFO - 'MAIL': '/var/mail/cltbld', 09:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:54 INFO - 'MOZ_NO_REMOTE': '1', 09:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:54 INFO - 'NO_EM_RESTART': '1', 09:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:54 INFO - 'PWD': '/builds/slave/test', 09:04:54 INFO - 'SHELL': '/bin/bash', 09:04:54 INFO - 'SHLVL': '1', 09:04:54 INFO - 'TERM': 'linux', 09:04:54 INFO - 'TMOUT': '86400', 09:04:54 INFO - 'USER': 'cltbld', 09:04:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', 09:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:54 INFO - '_': '/tools/buildbot/bin/python'} 09:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:54 INFO - Downloading/unpacking blobuploader==1.2.4 09:04:54 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 09:04:54 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 09:04:54 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 09:04:54 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 09:04:54 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 09:04:54 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 09:04:56 INFO - Downloading blobuploader-1.2.4.tar.gz 09:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:04:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:04:56 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 09:04:56 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 09:04:56 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 09:04:56 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 09:04:56 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 09:04:56 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 09:04:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:04:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:04:57 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 09:04:57 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 09:04:57 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 09:04:57 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 09:04:57 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 09:04:57 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 09:04:57 INFO - Downloading docopt-0.6.1.tar.gz 09:04:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:04:57 INFO - Installing collected packages: blobuploader, requests, docopt 09:04:57 INFO - Running setup.py install for blobuploader 09:04:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:04:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:04:57 INFO - Running setup.py install for requests 09:04:58 INFO - Running setup.py install for docopt 09:04:58 INFO - Successfully installed blobuploader requests docopt 09:04:58 INFO - Cleaning up... 09:04:58 INFO - Return code: 0 09:04:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:58 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 0x7f3c222e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf02410>, '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 0xf03310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf037a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', '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 09:04:58 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 09:04:58 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 09:04:58 INFO - Using env: {'DISPLAY': ':0', 09:04:58 INFO - 'HOME': '/home/cltbld', 09:04:58 INFO - 'LANG': 'en_US.UTF-8', 09:04:58 INFO - 'LANGUAGE': 'en_US:en', 09:04:58 INFO - 'LOGNAME': 'cltbld', 09:04:58 INFO - 'MAIL': '/var/mail/cltbld', 09:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:58 INFO - 'MOZ_NO_REMOTE': '1', 09:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:58 INFO - 'NO_EM_RESTART': '1', 09:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:58 INFO - 'PWD': '/builds/slave/test', 09:04:58 INFO - 'SHELL': '/bin/bash', 09:04:58 INFO - 'SHLVL': '1', 09:04:58 INFO - 'TERM': 'linux', 09:04:58 INFO - 'TMOUT': '86400', 09:04:58 INFO - 'USER': 'cltbld', 09:04:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', 09:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:58 INFO - '_': '/tools/buildbot/bin/python'} 09:04:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:04:58 INFO - Running setup.py (path:/tmp/pip-Dqs_Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:04:58 INFO - Running setup.py (path:/tmp/pip-_2cw8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:04:58 INFO - Running setup.py (path:/tmp/pip-m80jO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:04:58 INFO - Running setup.py (path:/tmp/pip-rwZd84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:04:58 INFO - Running setup.py (path:/tmp/pip-DckAvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:04:58 INFO - Running setup.py (path:/tmp/pip-taZN29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:04:58 INFO - Running setup.py (path:/tmp/pip-UdKftK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:04:58 INFO - Running setup.py (path:/tmp/pip-6cRDaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:04:58 INFO - Running setup.py (path:/tmp/pip-l8ynqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:04:59 INFO - Running setup.py (path:/tmp/pip-98flEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:04:59 INFO - Running setup.py (path:/tmp/pip-0FP2KX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:04:59 INFO - Running setup.py (path:/tmp/pip-KAZHIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:04:59 INFO - Running setup.py (path:/tmp/pip-ydDRej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:04:59 INFO - Running setup.py (path:/tmp/pip-l5QghW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:59 INFO - Running setup.py (path:/tmp/pip-rcRHeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:04:59 INFO - Running setup.py (path:/tmp/pip-C0CVVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:04:59 INFO - Running setup.py (path:/tmp/pip-tSOlFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:04:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:04:59 INFO - Running setup.py install for manifestparser 09:04:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:04:59 INFO - Running setup.py install for mozcrash 09:04:59 INFO - Running setup.py install for mozdebug 09:04:59 INFO - Running setup.py install for mozdevice 09:05:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:05:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:05:00 INFO - Running setup.py install for mozfile 09:05:00 INFO - Running setup.py install for mozhttpd 09:05:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:05:00 INFO - Running setup.py install for mozinfo 09:05:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:05:00 INFO - Running setup.py install for mozInstall 09:05:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:05:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:05:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:05:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:05:00 INFO - Running setup.py install for mozleak 09:05:00 INFO - Running setup.py install for mozlog 09:05:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:05:00 INFO - Running setup.py install for moznetwork 09:05:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:05:00 INFO - Running setup.py install for mozprocess 09:05:00 INFO - Running setup.py install for mozprofile 09:05:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:05:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:05:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:05:00 INFO - Running setup.py install for mozrunner 09:05:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:05:01 INFO - Running setup.py install for mozscreenshot 09:05:01 INFO - Running setup.py install for moztest 09:05:01 INFO - Running setup.py install for mozversion 09:05:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:05:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:05:01 INFO - Cleaning up... 09:05:01 INFO - Return code: 0 09:05:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:01 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 0x7f3c222e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf02410>, '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 0xf03310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf037a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', '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 09:05:01 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 09:05:01 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 09:05:01 INFO - Using env: {'DISPLAY': ':0', 09:05:01 INFO - 'HOME': '/home/cltbld', 09:05:01 INFO - 'LANG': 'en_US.UTF-8', 09:05:01 INFO - 'LANGUAGE': 'en_US:en', 09:05:01 INFO - 'LOGNAME': 'cltbld', 09:05:01 INFO - 'MAIL': '/var/mail/cltbld', 09:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:01 INFO - 'MOZ_NO_REMOTE': '1', 09:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:01 INFO - 'NO_EM_RESTART': '1', 09:05:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:01 INFO - 'PWD': '/builds/slave/test', 09:05:01 INFO - 'SHELL': '/bin/bash', 09:05:01 INFO - 'SHLVL': '1', 09:05:01 INFO - 'TERM': 'linux', 09:05:01 INFO - 'TMOUT': '86400', 09:05:01 INFO - 'USER': 'cltbld', 09:05:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', 09:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:01 INFO - '_': '/tools/buildbot/bin/python'} 09:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:01 INFO - Running setup.py (path:/tmp/pip-YjLiDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:01 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)) 09:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:01 INFO - Running setup.py (path:/tmp/pip-dsLrWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:01 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)) 09:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:01 INFO - Running setup.py (path:/tmp/pip-KKzsFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:01 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)) 09:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:01 INFO - Running setup.py (path:/tmp/pip-Uah81l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:01 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)) 09:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:01 INFO - Running setup.py (path:/tmp/pip-7EX0gL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:01 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)) 09:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:01 INFO - Running setup.py (path:/tmp/pip-MBIkUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:02 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)) 09:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:02 INFO - Running setup.py (path:/tmp/pip-6WT3S4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:02 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)) 09:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:02 INFO - Running setup.py (path:/tmp/pip-NtGZxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:02 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)) 09:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:02 INFO - Running setup.py (path:/tmp/pip-xpqosq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:02 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)) 09:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:02 INFO - Running setup.py (path:/tmp/pip-c5LQEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:02 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)) 09:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:02 INFO - Running setup.py (path:/tmp/pip-qvFTBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:02 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)) 09:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:02 INFO - Running setup.py (path:/tmp/pip-AElueO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:02 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)) 09:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:02 INFO - Running setup.py (path:/tmp/pip-aeh4Wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:02 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)) 09:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:02 INFO - Running setup.py (path:/tmp/pip-_1c5HJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:02 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)) 09:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:02 INFO - Running setup.py (path:/tmp/pip-EYmQn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:02 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)) 09:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:02 INFO - Running setup.py (path:/tmp/pip-LN1tYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:02 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)) 09:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:02 INFO - Running setup.py (path:/tmp/pip-GngOSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:02 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)) 09:05:02 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)) 09:05:02 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)) 09:05:02 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)) 09:05:02 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)) 09:05:02 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)) 09:05:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:04 INFO - Downloading blessings-1.6.tar.gz 09:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:05:04 INFO - Installing collected packages: blessings 09:05:04 INFO - Running setup.py install for blessings 09:05:04 INFO - Successfully installed blessings 09:05:04 INFO - Cleaning up... 09:05:04 INFO - Return code: 0 09:05:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:05:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:05 INFO - Reading from file tmpfile_stdout 09:05:05 INFO - Current package versions: 09:05:05 INFO - argparse == 1.2.1 09:05:05 INFO - blessings == 1.6 09:05:05 INFO - blobuploader == 1.2.4 09:05:05 INFO - docopt == 0.6.1 09:05:05 INFO - manifestparser == 1.1 09:05:05 INFO - mozInstall == 1.12 09:05:05 INFO - mozcrash == 0.17 09:05:05 INFO - mozdebug == 0.1 09:05:05 INFO - mozdevice == 0.48 09:05:05 INFO - mozfile == 1.2 09:05:05 INFO - mozhttpd == 0.7 09:05:05 INFO - mozinfo == 0.9 09:05:05 INFO - mozleak == 0.1 09:05:05 INFO - mozlog == 3.1 09:05:05 INFO - moznetwork == 0.27 09:05:05 INFO - mozprocess == 0.22 09:05:05 INFO - mozprofile == 0.28 09:05:05 INFO - mozrunner == 6.11 09:05:05 INFO - mozscreenshot == 0.1 09:05:05 INFO - mozsystemmonitor == 0.0 09:05:05 INFO - moztest == 0.7 09:05:05 INFO - mozversion == 1.4 09:05:05 INFO - psutil == 3.1.1 09:05:05 INFO - requests == 1.2.3 09:05:05 INFO - wsgiref == 0.1.2 09:05:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:05 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 0x7f3c222e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf02410>, '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 0xf03310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf037a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', '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 09:05:05 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 09:05:05 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 09:05:05 INFO - Using env: {'DISPLAY': ':0', 09:05:05 INFO - 'HOME': '/home/cltbld', 09:05:05 INFO - 'LANG': 'en_US.UTF-8', 09:05:05 INFO - 'LANGUAGE': 'en_US:en', 09:05:05 INFO - 'LOGNAME': 'cltbld', 09:05:05 INFO - 'MAIL': '/var/mail/cltbld', 09:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:05 INFO - 'MOZ_NO_REMOTE': '1', 09:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:05 INFO - 'NO_EM_RESTART': '1', 09:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:05 INFO - 'PWD': '/builds/slave/test', 09:05:05 INFO - 'SHELL': '/bin/bash', 09:05:05 INFO - 'SHLVL': '1', 09:05:05 INFO - 'TERM': 'linux', 09:05:05 INFO - 'TMOUT': '86400', 09:05:05 INFO - 'USER': 'cltbld', 09:05:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', 09:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:05 INFO - '_': '/tools/buildbot/bin/python'} 09:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:05 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)) 09:05:05 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)) 09:05:05 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)) 09:05:05 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)) 09:05:05 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)) 09:05:05 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)) 09:05:05 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)) 09:05:05 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)) 09:05:05 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)) 09:05:05 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)) 09:05:05 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)) 09:05:05 INFO - Cleaning up... 09:05:05 INFO - Return code: 0 09:05:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:05 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 0x7f3c222e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf02410>, '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 0xf03310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf037a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', '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 09:05:05 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 09:05:05 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 09:05:05 INFO - Using env: {'DISPLAY': ':0', 09:05:05 INFO - 'HOME': '/home/cltbld', 09:05:05 INFO - 'LANG': 'en_US.UTF-8', 09:05:05 INFO - 'LANGUAGE': 'en_US:en', 09:05:05 INFO - 'LOGNAME': 'cltbld', 09:05:05 INFO - 'MAIL': '/var/mail/cltbld', 09:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:05 INFO - 'MOZ_NO_REMOTE': '1', 09:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:05 INFO - 'NO_EM_RESTART': '1', 09:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:05 INFO - 'PWD': '/builds/slave/test', 09:05:05 INFO - 'SHELL': '/bin/bash', 09:05:05 INFO - 'SHLVL': '1', 09:05:05 INFO - 'TERM': 'linux', 09:05:05 INFO - 'TMOUT': '86400', 09:05:05 INFO - 'USER': 'cltbld', 09:05:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', 09:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:05 INFO - '_': '/tools/buildbot/bin/python'} 09:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:05 INFO - Downloading/unpacking jsonschema 09:05:05 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 09:05:05 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 09:05:05 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 09:05:05 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 09:05:05 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 09:05:05 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 09:05:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:05:07 INFO - Downloading/unpacking functools32 (from jsonschema) 09:05:07 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 09:05:07 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 09:05:07 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 09:05:07 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 09:05:07 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 09:05:07 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 09:05:07 INFO - Downloading functools32-3.2.3-2.tar.gz 09:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:05:07 INFO - warning: no files found matching '*.txt' 09:05:07 INFO - no previously-included directories found matching 'build' 09:05:07 INFO - no previously-included directories found matching 'dist' 09:05:07 INFO - no previously-included directories found matching '.git*' 09:05:07 INFO - Installing collected packages: jsonschema, functools32 09:05:07 INFO - Running setup.py install for functools32 09:05:07 INFO - warning: no files found matching '*.txt' 09:05:07 INFO - no previously-included directories found matching 'build' 09:05:07 INFO - no previously-included directories found matching 'dist' 09:05:07 INFO - no previously-included directories found matching '.git*' 09:05:07 INFO - Successfully installed jsonschema functools32 09:05:07 INFO - Cleaning up... 09:05:07 INFO - Return code: 0 09:05:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:07 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 0x7f3c222e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe735a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf02410>, '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 0xf03310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf037a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', '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 09:05:07 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 09:05:07 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 09:05:07 INFO - Using env: {'DISPLAY': ':0', 09:05:07 INFO - 'HOME': '/home/cltbld', 09:05:07 INFO - 'LANG': 'en_US.UTF-8', 09:05:07 INFO - 'LANGUAGE': 'en_US:en', 09:05:07 INFO - 'LOGNAME': 'cltbld', 09:05:07 INFO - 'MAIL': '/var/mail/cltbld', 09:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:07 INFO - 'MOZ_NO_REMOTE': '1', 09:05:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:07 INFO - 'NO_EM_RESTART': '1', 09:05:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:07 INFO - 'PWD': '/builds/slave/test', 09:05:07 INFO - 'SHELL': '/bin/bash', 09:05:07 INFO - 'SHLVL': '1', 09:05:07 INFO - 'TERM': 'linux', 09:05:07 INFO - 'TMOUT': '86400', 09:05:07 INFO - 'USER': 'cltbld', 09:05:07 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', 09:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:07 INFO - '_': '/tools/buildbot/bin/python'} 09:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:08 INFO - Downloading/unpacking flake8 09:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:05:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:05:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:05:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:05:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:05:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:05:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:05:10 INFO - no previously-included directories found matching 'docs/_build' 09:05:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:05:10 INFO - Running setup.py install for pep8 09:05:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:05:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:05:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:05:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:05:10 INFO - no previously-included directories found matching 'docs/_build' 09:05:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:05:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:05:10 INFO - Cleaning up... 09:05:11 INFO - Return code: 0 09:05:11 INFO - Running post-action listener: _resource_record_post_action 09:05:11 INFO - Running post-action listener: _start_resource_monitoring 09:05:11 INFO - Starting resource monitoring. 09:05:11 INFO - ##### 09:05:11 INFO - ##### Running install step. 09:05:11 INFO - ##### 09:05:11 INFO - Running pre-action listener: _resource_record_pre_action 09:05:11 INFO - Running main action method: install 09:05:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:11 INFO - Reading from file tmpfile_stdout 09:05:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:05:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:05:11 INFO - Reading from file tmpfile_stdout 09:05:11 INFO - Output received: 09:05:11 INFO - Usage: mozinstall [options] installer 09:05:11 INFO - Options: 09:05:11 INFO - -h, --help show this help message and exit 09:05:11 INFO - -d DEST, --destination=DEST 09:05:11 INFO - Directory to install application into. [default: 09:05:11 INFO - "/builds/slave/test"] 09:05:11 INFO - --app=APP Application being installed. [default: firefox] 09:05:11 INFO - mkdir: /builds/slave/test/build/application 09:05:11 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'] 09:05:11 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 09:05:27 INFO - Reading from file tmpfile_stdout 09:05:27 INFO - Output received: 09:05:27 INFO - /builds/slave/test/build/application/firefox/firefox 09:05:27 INFO - Running post-action listener: _resource_record_post_action 09:05:27 INFO - ##### 09:05:27 INFO - ##### Running run-tests step. 09:05:27 INFO - ##### 09:05:27 INFO - Running pre-action listener: _resource_record_pre_action 09:05:27 INFO - Running main action method: run_tests 09:05:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:05:27 INFO - Python 2.7.3 09:05:27 INFO - Return code: 0 09:05:27 INFO - grabbing minidump binary from tooltool 09:05: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')]} 09:05:27 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 0xf02410>, '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 0xf03310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf037a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:05:27 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 09:05:27 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 09:05:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:05:27 INFO - Return code: 0 09:05:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:05:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:05:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:05:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:05:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:05:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:05:28 INFO - Return code: 0 09:05:28 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/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:05:28 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/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:05:28 INFO - Using env: {'DISPLAY': ':0', 09:05:28 INFO - 'HOME': '/home/cltbld', 09:05:28 INFO - 'LANG': 'en_US.UTF-8', 09:05:28 INFO - 'LANGUAGE': 'en_US:en', 09:05:28 INFO - 'LOGNAME': 'cltbld', 09:05:28 INFO - 'MAIL': '/var/mail/cltbld', 09:05:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:05:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:28 INFO - 'MOZ_NO_REMOTE': '1', 09:05:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:28 INFO - 'NO_EM_RESTART': '1', 09:05:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:28 INFO - 'PWD': '/builds/slave/test', 09:05:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:05:28 INFO - 'SHELL': '/bin/bash', 09:05:28 INFO - 'SHLVL': '1', 09:05:28 INFO - 'TERM': 'linux', 09:05:28 INFO - 'TMOUT': '86400', 09:05:28 INFO - 'USER': 'cltbld', 09:05:28 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357', 09:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:28 INFO - '_': '/tools/buildbot/bin/python'} 09:05:28 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/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:05:28 INFO - mozversion application_buildid: 20160426084505 09:05:28 INFO - mozversion application_changeset: 5ffdd1bafd496a5e9ca0d32f9729333d1b467eb4 09:05:28 INFO - mozversion application_display_name: Nightly 09:05:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:05:28 INFO - mozversion application_name: Firefox 09:05:28 INFO - mozversion application_remotingname: firefox 09:05:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:05:28 INFO - mozversion application_vendor: Mozilla 09:05:28 INFO - mozversion application_version: 49.0a1 09:05:28 INFO - mozversion platform_buildid: 20160426084505 09:05:28 INFO - mozversion platform_changeset: 5ffdd1bafd496a5e9ca0d32f9729333d1b467eb4 09:05:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:05:28 INFO - mozversion platform_version: 49.0a1 09:05:28 INFO - using testdate: 1461686728 09:05:28 INFO - actual date: 1461686728 09:05:28 INFO - starting webserver on 'localhost:57937' 09:05:28 INFO - SUITE-START | Running 2 tests 09:05:28 INFO - TEST-START | dromaeo_css 09:05:28 INFO - operating with platform_type : linux_ 09:05:28 INFO - Initialising browser for dromaeo_css test... 09:05:28 INFO - TEST-INFO | started process 21254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCbX76e/profile http://localhost:57937/getInfo.html) 09:05:32 INFO - PROCESS | 21254 | 09:05:32 INFO - PROCESS | 21254 | (process:21323): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:05:32 INFO - PROCESS | 21254 | __metrics Screen width/height:1600/1200 09:05:32 INFO - PROCESS | 21254 | colorDepth:24 09:05:32 INFO - PROCESS | 21254 | Browser inner width/height: 1024/697 09:05:32 INFO - PROCESS | 21254 | __metrics 09:05:33 ERROR - PROCESS | 21254 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:05:34 INFO - TEST-INFO | 21254: exit 0 09:05:34 INFO - Browser initialized. 09:05:34 INFO - Running cycle 1/1 for dromaeo_css test... 09:05:34 INFO - TEST-INFO | started process 21374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCbX76e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:05:36 INFO - PROCESS | 21374 | 09:05:36 INFO - PROCESS | 21374 | (process:21434): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:05:46 INFO - PROCESS | 21374 | RSS: Main: 166064128 09:05:46 INFO - PROCESS | 21374 | 09:06:36 INFO - PROCESS | 21374 | 1461686796024 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] 09:08:47 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:57937/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57937/tests/dromaeo/cssquery-ext.html) 09:08:48 INFO - PROCESS | 21374 | RSS: Main: 168251392 09:08:48 INFO - PROCESS | 21374 | 09:11:50 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:57937/tests/dromaeo/cssquery-ext.html (next: http://localhost:57937/tests/dromaeo/cssquery-jquery.html) 09:11:51 INFO - PROCESS | 21374 | RSS: Main: 166408192 09:11:51 INFO - PROCESS | 21374 | 09:14:52 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:57937/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57937/tests/dromaeo/cssquery-mootools.html) 09:14:53 INFO - PROCESS | 21374 | RSS: Main: 168058880 09:14:53 INFO - PROCESS | 21374 | 09:17:55 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:57937/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57937/tests/dromaeo/cssquery-prototype.html) 09:17:55 INFO - PROCESS | 21374 | RSS: Main: 165724160 09:17:55 INFO - PROCESS | 21374 | 09:20:58 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:57937/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57937/tests/dromaeo/cssquery-yui.html) 09:20:59 INFO - PROCESS | 21374 | RSS: Main: 166887424 09:20:59 INFO - PROCESS | 21374 | 09:24:01 INFO - PROCESS | 21374 | Cycle 1(1): loaded http://localhost:57937/tests/dromaeo/cssquery-yui.html (next: http://localhost:57937/tests/dromaeo/cssquery-dojo.html) 09:24:01 INFO - PROCESS | 21374 | RSS: Main: 168726528 09:24:01 INFO - PROCESS | 21374 | 09:24:01 INFO - PROCESS | 21374 | __start_tp_report 09:24:01 INFO - PROCESS | 21374 | _x_x_mozilla_page_load 09:24:01 INFO - PROCESS | 21374 | _x_x_mozilla_page_load_details 09:24:01 INFO - PROCESS | 21374 | |i|pagename|runs| 09:24:01 INFO - PROCESS | 21374 | |0;dojo.html;2568.589025755879;2659.1756555467814;2665.8400495970245;2676.2907829425194;2677.879495422707;4553.977230113845;4613.907721845561;4622.144903192908;4627.097715945388;4660.953390466094;4487.551244875511;4581.060882519084;4585.151746926821;4589.036302376497;4599.241125214336;4169.937450938239;4205.894852628679;4232.936505952413;4326.653867690593;4338.197433474801;4276.144771045788;4285;4315.115401342718;4331.068820203672;4344.543822898598;4162;4301.870943871673;4319.611234988851;4334.718243314174;4370.147821174872;4249.893752656178;4254.638355739766;4262.616364527176;4270.12462445198;4278.743275403454;4172.102997855475;4209.431726716915;4274.316109422478;4295.806688699016;4312.37470566766;4340.175366680321;4443.200223959686;4548.317752337143;4584.174848527264;4595.517470665599;4852.247901575226;4922.655414121013;4923.532264434909;4927.236278376858;4936.4076310842565;4927.426278275811;4991.975040124777;5008.924866127011;5020.824271150529;5025.396952365703;4644.419447569054;4652.930206046912;4707.105649926503;4717.080169366941;4720;5014.373203349582;5016.44819069902;5022.9748851256245;5024.045431368028;5027.597792176617;4779.880502987453;4792.137415265216;4829.806807727722;4835.709857408567;4881.926771098437;4761.428628564595;4897.608191344684;4931.852044438672;4969.577585905166;4982.9252561211615;4885.682430641997;4903.656744027955;4920.335754673145;4927.187014142698;4972.602191824645;4813.542713442287;4914.533119353656;4918.311436398907;4924.901501969941;4975.353204083446;4190.622843944059;4267.8079486423185;4302.720323178984;4324.286492728727;4343.891402714958;3687.870924517629;3740.6259374062374;3764.3412402829395;3780.2061567070673;3806.1626442182674;4332.00363916301;4343.218220720238;4354.56454354562;4363.5418281080665;4402.867913962522;4797.088553174955;4947.035328110984;4958.033183529177;5024.924626130611;5047.394312682502;4249.68127390447;4250;4270.359446083113;4285.10012897295;4289.1421715657;4414.757188354607;4448.243798554254;4449.065696203834;4454.621357184676;4505.121501307213;4627.444706635225;4642.419697537808;4652;4665.836695715634;4704.764761761899;4858.878528036827;4916.508349165055;4927.60579153674;4930.630202734737;4966.776495057803;4584.931226031679;4620.699654522446;4667.369905062773;4679.227927391942;4709.317149013305;4888.60891128716;4892.2661600760175;4892.90214195707;4893.241547560134;4920.360353154067;4916.631252655993;4918.827841025547;4936.531029552187;4940.925886111783;4946.950530494649;4689.390379250675;4763.16644587189;4834.951650483591;4851.32081508582;4874.2201247800185;4806.735629540409;4822.228443449031;4827;4838.250071238964;4882.316475693477;4747.477777444547;4770.0936822003705;4778.522147785194;4791.760411979318;4818.95181048185;4732.408448943882;4807.759612019315;4866.270059491105;4866.48901865299;4910.582600478856;4640.883977900579;4717.669763116549;4751.097291514601;4789.377380940456;4815.422149342101 09:24:01 INFO - PROCESS | 21374 | |1;ext.html;555.7788595616292;589.985250368741;590.5039766596059;601.1193601373988;629.9496040316775;31628.68371316286;32266.193345166383;32314.192145196383;32381;32399;35119.122021949464;35902;36188.095297617576;36226.10191184706;36227.637723622756;7350.264973502647;7513.962430187841;7515.887261691079;7516.098068231792;7518.8120296992465;7443.367313778335;7540.622968851563;7585.469017168801;7593.924060759405;7607.771766847003;7515.098188217422;7578.469507134503;7584.886226706604;7653.1964143764935;7657.272559106876;7491.550506969572;7519.323260906544;7586.051743532059;7588.962055189744;7598.240175982412;7410.2589741026;7486.9251307486775;7487;7492.063492063492;7539.547627142334;23736.169234076726;30473.39053218923;30737.38525229505;31120;31180.220494487592;2685.5031819113333;2724.087430710714;2728.4952283827356;2760.2409337432164;2777.319556708599;24373.756262437328;25580.97676092954;26011.869940650366;26694.19917402481;26835.731642683517;3368.7641865069454;3397.524346591479;3516.050666320105;3593.4609808528667;3620.945685814715;114467.42766286198;115240.42379788132;115437;115595.42202289018;116435.41782291119;34233.31533369319;34369.82815085958;34395.14012149716;34397.31205375878;34538.13654658654;41069.58930410658;41290.587094129274;41437;41537.792311038254;44398;13267.270300133392;13600.59198224035;13635.250061246727;13660.86339136596;13689;9645.90354096464;9649.469279189572;9688.224942004623;9725.513724313756;9729.56216970238;14749.705005899821;14904.478343257933;14937.327820248114;14983.175925323994;15766.68466630661;5905.350411454737;6004.489618382399;6053.545984051214;6059.575829691968;6094.512439004869;727.92362768496;865.2472349056361;886.8758373827669;906.5603182456504;1006.6023920551341;24914.501709965698;26055.03130612545;26363.73636263651;26385.73614263871;26462.470750584882;877.9868301975475;885.2519620920312;895.713371721043;926.8146370725882;1002.2132625888643;12875.678108047374;13251.271180085188;13498.93250533741;13506.662333441545;13578.728425431436;275874;278445;281277;282310;283880;38658.42012369817;38679.80660096682;38909.22181556353;39011.41482877759;39286;1096.8903109688968;1131.7000994736402;1134.8184290513477;1134.982975255372;1173.0263880978766;22835.657465138367;23963.400914977265;24281.392965175306;24350;24534.141305054236;33085.17287067843;34263.486047709805;34386.656133438344;34428;34591.481127783605;254851;255417;258001;258114;258492;31452.842735786173;32062.519062214553;32326.676733232365;32364.514532281562;32518;34262.14344641404;35335;35434.645653543135;35480.82259588789;35725.28549428945;30081.69918300789;30171.396572068876;30324.5451318226;30740.69259307378;30838;29776.553351700175;30012.24969375783;30406.23984400319;30549.847250763603;30802.69197308088;25024.874875625505;27451.450970980866;28040.71959280381;30284.69715302907;30634.85556011058;25234.873825630755;26397.60403593986;26938;27042.360438286858;27048.864755676095;22008.779912200673;22136.335909922727;22467.550648986602;22556.210532631278;22560.774392255866 09:24:01 INFO - PROCESS | 21374 | |2;jquery.html;359.2330374650121;367.50937498439583;368.4307744534694;371.79922841665496;381.19377516552464;14171.433142674294;14315;15293.082415055076;15295.15876626785;15302.464413745507;13701.65745856354;14246.430142794276;15128.470503532379;15272.854535909824;15381.923090384533;4547.86303424144;4969.10556099901;5109.795608175668;5112.846614601568;5141.15170996785;5043.873903152432;5067.113255180328;5071.695698258098;5076.263941728447;5086.364204474441;4760.976195119037;5002.7248501332415;5063.443021267658;5069.062223488648;5070.847874563769;4981.352424184869;4990.101781679296;4992.201247800353;5000.224965130411;5034.672746271499;4320.956790432118;4500.212462819027;4504.752238626874;4531.52418996004;4539.750313732743;17483;17784.110794460226;17987.19057642409;17992.640147196984;18171;1728.7752592163065;1868.2900497810745;1902.1155162849202;2026.4528577284198;2098.9055492502875;7899.842003159962;8119.675212991473;8123.553204573746;8192.057913339982;8362.623681934327;1803.3147403986532;1828.0494143045676;1837.1916356803097;1846;1849.8890066595914;46875;49977.500224997646;52963.47036529624;53949.99999999961;55215;8776.210141087206;9026;9124.543772811465;9362.344635875423;9445.811083778286;12904.29026403538;12960.351982400842;12986.090973631755;13001.609951701465;13007.674808129872;6639.136912201383;6667.366600172976;6915.446764258847;6967.54710943787;6991.825204369829;6400.295967443578;6467.223933128054;6570.244421891448;6580.670966451658;6620.569662971891;4119.0937993641355;4153.626173644387;4189.308764053897;4243.745375277432;4284.592963668447;1713.6144367517459;1802.0809387212355;1815.727640853856;1827.1229809691156;1834.3763120539081;795.4551132474273;813.9674413023531;827.8302947895667;881.2245224202661;883.6067949762422;14600.12399256048;15025.323860426308;15135;15453.459128930434;15470.226488675522;815.7776781712261;824.2746383182761;830.9293710034715;830.9626066827008;836.2682652678906;8524.914750852413;8762;8772.473651580925;8877.822443551093;8893.333000025024;344194;346974;351749;358031;360460;66423;66636;66841.33158668448;67242.66378668076;68040.65979670169;755.6297414266969;808.9191080891982;861.642418396371;863.0161615758041;864.991350086491;12614.49542018309;13306.401211945293;13587.728245435233;13936.303184840921;14005.089669171472;28470.85764571247;29147.562786558643;29611.111666650035;30349.393012139193;30735.692643073282;38731.80634096811;43588.34617480804;43608.12783744244;43780.56219437892;44049;7434.788673455344;7540.359069479156;7639.770806875803;7737.497062690907;7765.41759368061;10368.792624147625;11165.553377864795;11286;11485.253458525503;11529.654110376701;9608.423494590346;9952.402855828674;10026.949865250626;10108.545115469675;10328.948355258175;9599.712008639752;9687.757806054906;9718;9772.9022709772;10102.444365559964;9875.456849873326;9972.30193886421;10023.047810457994;10257.230707697101;10444.268901177149;6815.318468153343;7242.855142897218;7506.887396688945;7661.310482056641;7760.18518055596;8523.95738021306;9569.952150239482;9581.377210481296;9612.231021518122;9716.368436051634 09:24:01 INFO - PROCESS | 21374 | |3;mootools.html;1277.8849903508683;1308.627041293231;1316.9539066132686;1475.9926200368996;1502.8046353973982;6422.068800024005;7148.606826624534;7216.422686185106;7471.476996610239;7553.735619253321;7131.964340178305;7148.96425517873;7185.604791736452;7212.855742885139;7228.4217262618995;2142.6250406178897;2166.11189412341;2168.30614203455;2169.783021697833;2183;2082.864613800098;2083.125087463269;2183.9563208735817;2200.6368949123375;2204.129368899292;2159.481724386144;2161.416417567256;2161.9567608647817;2170.4573856535867;2201.6147174244525;2068.896555172243;2090.46693093261;2098.5383215692523;2099.548597051626;2109.45154259892;2065.8863762493056;2079.6152711748223;2104.2424727098387;2106.547092375147;2116.047778499666;7277.454190935701;7347.6326183691135;7405.222451642608;7405.925940740577;7411.0736157980255;4426.911461770746;4562.885927851797;4584.724916504987;4607.424071991001;4610.5389461053965;2860.5852151438135;2955.0986948980553;3030.3333266681293;3036.1650546099777;3047.085874237742;886.7206829848642;904.9909500905038;912.2929729459655;949.1410273702311;949.6533765175731;10700.197485188564;10702.411367374869;10727.08819750322;10744.355338679705;10752.354858708424;4266.253405653998;4315.482142142901;4324.78376081201;4339.067100573392;4345.304751239786;9146.81706365869;9152.8627070594;9179;9207.769805754775;9211.76970575741;4499.482559505699;4567.040921406542;4576.176288268143;4595.494495605481;4600.401947746838;3522.5244591980268;4054.108096218886;4108.198901214294;4190.664746820247;4214.304639734471;3439.0370696205105;3450.344434557426;3550.840212190458;3559.715222782171;3571.2500374921037;1151.3494875395374;1153.1005815463952;1154.1978325064;1160.3733983648904;1164.6214980131492;688.0814113158889;809.1827254473025;813.9321359266653;841.7433130102427;846.3652260804397;5206.5314121729225;5330.840074797762;5400.405955344909;5412.107002344569;5418.647787893774;374.88940762475136;379.87654012446063;382.2660491855588;390.9687225021991;396.8710169195023;3359.9664003360144;3364.327134573095;3418.777779444328;3439.4840773883616;3463.6363181866045;9160.6793762218;9319.673811416567;9450.338476306593;9616.95191524038;9653.46905920181;9412.67055653049;9494.762630934143;9496.47769372691;9542.475163866055;9546.093121153479;6942.583444993316;6961.965190174017;7039.401650859734;7062.152541694927;7079.89380159298;5125.846224613268;5152.899371971866;5232.424433312409;5233.869153271199;5328.200769884394;8832.646694132163;8889.911100888909;8909.910900890907;8928.464292142493;8993.910060899307;8811.339149563937;8897.822043559223;8926.509042002752;9065;9173.31200160004;5395;6602.702878370581;6644.402003819486;6701.530892837454;6838.965805170942;7076.858462830817;7115.6086415247655;7137.928620713934;7140.821479463055;7198.4601154914635;6380.93619063822;6511.511636627177;6523.3476652336285;6702.698378572878;6782.762603308861;6329.810105696836;6338.904916426165;6392.232932048184;6642.136522252076;6682.131322927989;5996.430339117776;6050.6369617823075;6067.514598831995;6072;6073.453389194994;4212.347086201644;4230.767307798101;4334.79249178606;4385.298352263622;4446.688731788744;4398.494173169998;4402.2516172251435;4499;4532.818687252473;4532.932006019978 09:24:01 INFO - PROCESS | 21374 | |4;prototype.html;290.32789093249113;294.2247178684167;297.79154591785755;300.9699030096989;316.6516831485368;4729.29060640904;4835.9274610880775;4879.536139158252;4950.950490495089;4968.527989840968;4862.416510018803;4873.439554451239;4899.657024008321;4912.557869791718;4913.877153071175;3850.5379354477363;3866.76799392036;3884.6892248620184;3888.8444462221546;3912.3544615138467;3621.4386770050683;3867.671247943928;3899.78551179685;3901.239258344624;3926.3325234710023;3817.4655548223272;3822.541295044585;3832.5400951885813;3835.1179228777396;3844.8654297099606;3807.619238076198;3819.8090095495254;3824.9808750956345;3828.464015037897;3835.0987517933263;3371.494275858616;3381.39383792699;3381.628020917697;3389.5593572835373;3402.812845293508;4625.745583992879;4740.715557066587;4748.548887855648;4756.738379389132;4761;4320.611144996966;4364.5635436456105;4367.54140815213;4380.715253508543;4395.582419670126;5122.820701275437;5134;5135.6918584885025;5163.690178589259;5174.120399532088;3583.7670551414076;3652.0889030764847;3659.8170091495317;3666.120131168527;3690.6862916652117;5297.364316282033;5351.224072509464;5370.731463426813;5414.3232095988005;5444.3194600674915;3706.629337066272;3708.6662200402093;3716.758410703296;3724.7206459515646;3728.832202550892;3755.511783468132;3779.6787273081545;3780.678642315434;3782.205736795249;3788.583255841855;4080.530738965057;4343.305071188594;4344.956550434518;4346.261495401802;4358.128374325148;5174;5175.689458632494;5180.974095129575;5192.350956130484;5206.114960456732;1304.5173285884284;1334.9065565410328;1379.5102738527878;1382.0671047043206;1384.4254634326844;904.6291020681489;924.653255029364;931.1852129386787;940.3746508571724;941.2799208605422;4799.448063472745;4807.423109226916;4808.927866082012;4832.4684284728655;4842.128416884924;5640.407757185519;5645.633033852787;5665.631733937281;5691.4877661010705;5701.486866182064;4709.3877795887;4801.927971080437;4846.400687773026;4852.0295940811975;4867.659263851497;3028.8485575721566;3032.6815684353264;3036.3320069584656;3041.847907604611;3050.633923929143;5318.228856815817;5332.466753324637;5340.572754179656;5341.65279256847;5360.678359298455;5606.206014075457;5727.5131613812455;5762.279715035621;5785.334686511105;5822.097574875901;5272.103742363807;5315.388730295988;5320.084769482983;5326.627136100436;5327.200919862052;5511.200875873056;5612.971935140298;5626.2685850839125;5635.802746903839;5649.248732892816;5484.945150548443;5490.862728431821;5503.9174412383045;5506.476884695948;5533.363663178625;5217.6086793491395;5254.842354729364;5262.315898933267;5286.8942621148135;5305.628605997543;3785.312428176026;3872.8838134856;3901.6878649708524;3920.6471417572557;3935.803209839554;5077.339945807022;5656.604037717485;5666.886662266649;5672.602917795714;5682.829515114553;4998.900021999612;5175.870603234949;5177.145770947752;5181.792728290826;5185.818496352609;5098.923516147335;5142.948570514247;5143.92284115731;5147.819826306061;5178.559822415137;4810.278458231153;5041.6470847040355;5065.39215294167;5075.213341932006;5123.948760512347;5171.456997015259;5180.057478445583;5190.506901844319;5206.375234971828;5217.634765566374;5031.572316353151;5056.7471626419265;5063.088644044107;5098.872528186825;5129.410117836496 09:24:01 INFO - PROCESS | 21374 | |5;yui.html;617.4103730936954;702.6100514214612;709.3686618909169;711.2176605733692;718.0736849464191;11840.526378944842;12454.128211025232;12672.873271267285;13095.47618095275;13484.190948543095;11843.348615826126;11927.940360298186;11941.164118511708;11952.163348565604;12048.7590248195;501.75414047116834;537.6747068023848;537.9623426360147;538.0422847331756;545.912653975364;628.4595248086641;644.9613023218599;649.9545031847773;652.363945153474;653.9705713242892;594.5392320951254;598.706633749464;602.4698265526331;610.3774150366623;611.7430679114782;620.0791824141147;637.2639601260528;638.399904090156;642.2293248102296;645.6190847400034;528.3633221967519;533.938597061339;542.3627237995379;553.573748213873;566.2497191221648;10978.670639880816;11034.227604067719;11036.834447483294;11075.833862491989;11077.778444431147;10927.235093543455;10928.453577321103;11314.717132071682;11817.527298908033;12070.758584828342;9451.858222126673;9464.148226659565;9496.810063798754;9505.144536991704;9734;3286.967130328714;3307.9503807442907;3433.7081348085444;3434.038469228595;3440.6043305019994;42898.35652465184;43447.348289775364;43846.561534384884;44017.339739903924;44189.558104419186;8744.69393571222;9013.774655633662;9048.049954754788;9107.499087550115;9121.45271283725;15441.0735355879;15458.149801760786;15496.612584685248;15553.922230388776;15780.210989450481;6231.626102433868;6287.805316989758;6463.289038205794;6463.967680161569;6469.223693156757;3527.982360088183;3548.9645103548633;3604.8738294160103;3614.98192509041;3695.316366472211;2588;2594.2347007632793;2595.493878693637;2623.8819253133656;2651.8862077927315;484.2832607740493;484.3292040523829;487.7561219390305;489.06100287448186;496.5183771741405;564.1847530318651;564.3932772269744;574.3882764855416;587.7011803913399;595.5414330965133;8025.398095142771;8100.594970251464;8217.506949583045;8283.08886022537;8410.747677569683;507.92888995540653;517.0770175237259;568.7724910036019;571.4999375546397;574.8045664474099;3676.485292059114;3765.642263984917;3768.4347347897487;3849.2301539692176;3873.5932727063814;49801.25298120531;49925.75037124791;52550.47449525532;52942.35288235573;52992.47007529953;45532.3170152448;45830;45917.7704111484;46909.53090469052;48356.75821620869;43111.784441077594;43273.13453730908;43312.13375732468;43609.34585981213;43616.56383436125;7268.418526517971;7440.2931721486375;7461.179270280373;7514.661840217313;7543.207963163789;28230.71769282363;29429.852850736464;29539.85230073836;29864.402711945204;30239.848800755855;35611.643883560835;35922.640773592975;37477.62522374741;37523.06192345213;38256.80871595624;8942.239909607497;9017.729468115967;9139.177474027369;9230.35387522867;9257.814843702954;9913.55389007482;10103.848442273225;10107.292489525662;10581.682549523526;10595.15238780911;9654.372465789702;9682.951585242028;9742.610295588098;9810;9895.604175833174;9226.308026897876;9361.906380936376;9487.350693671473;9595.904040959502;9627.277954153607;9707.563159657691;9736.123748862636;9827.11555959967;9874.456904870302;9935.900640993497;8441.36689748259;8519.829603407774;8736.563171841255;8751.256143227896;8763.737087887373;7762.5730584818375;8169.5098294102545;8247.505149691038;8259.504429734236;8276.793080173044 09:24:01 INFO - PROCESS | 21374 | __end_tp_report 09:24:01 INFO - PROCESS | 21374 | __start_cc_report 09:24:01 INFO - PROCESS | 21374 | _x_x_mozilla_cycle_collect,364 09:24:01 INFO - PROCESS | 21374 | __end_cc_report 09:24:01 INFO - PROCESS | 21374 | __startTimestamp1461687841763__endTimestamp 09:24:01 INFO - PROCESS | 21374 | 09:24:01 INFO - PROCESS | 21374 | ------- Summary: start ------- 09:24:01 INFO - PROCESS | 21374 | Number of tests: 6 09:24:01 INFO - PROCESS | 21374 | 09:24:01 INFO - PROCESS | 21374 | [#0] dojo.html Cycles:165 Average:4576.77 Median:4704.76 stddev:456.03 (9.7%) stddev-sans-first:429.36 09:24:01 INFO - PROCESS | 21374 | Values: 2568.6 2659.2 2665.8 2676.3 2677.9 4554.0 4613.9 4622.1 4627.1 4661.0 4487.6 4581.1 4585.2 4589.0 4599.2 4169.9 4205.9 4232.9 4326.7 4338.2 4276.1 4285.0 4315.1 4331.1 4344.5 4162.0 4301.9 4319.6 4334.7 4370.1 4249.9 4254.6 4262.6 4270.1 4278.7 4172.1 4209.4 4274.3 4295.8 4312.4 4340.2 4443.2 4548.3 4584.2 4595.5 4852.2 4922.7 4923.5 4927.2 4936.4 4927.4 4992.0 5008.9 5020.8 5025.4 4644.4 4652.9 4707.1 4717.1 4720.0 5014.4 5016.4 5023.0 5024.0 5027.6 4779.9 4792.1 4829.8 4835.7 4881.9 4761.4 4897.6 4931.9 4969.6 4982.9 4885.7 4903.7 4920.3 4927.2 4972.6 4813.5 4914.5 4918.3 4924.9 4975.4 4190.6 4267.8 4302.7 4324.3 4343.9 3687.9 3740.6 3764.3 3780.2 3806.2 4332.0 4343.2 4354.6 4363.5 4402.9 4797.1 4947.0 4958.0 5024.9 5047.4 4249.7 4250.0 4270.4 4285.1 4289.1 4414.8 4448.2 4449.1 4454.6 4505.1 4627.4 4642.4 4652.0 4665.8 4704.8 4858.9 4916.5 4927.6 4930.6 4966.8 4584.9 4620.7 4667.4 4679.2 4709.3 4888.6 4892.3 4892.9 4893.2 4920.4 4916.6 4918.8 4936.5 4940.9 4947.0 4689.4 4763.2 4835.0 4851.3 4874.2 4806.7 4822.2 4827.0 4838.3 4882.3 4747.5 4770.1 4778.5 4791.8 4819.0 4732.4 4807.8 4866.3 4866.5 4910.6 4640.9 4717.7 4751.1 4789.4 4815.4 09:24:01 INFO - PROCESS | 21374 | 09:24:01 INFO - PROCESS | 21374 | [#1] ext.html Cycles:180 Average:35724.82 Median:32290.19 stddev:60245.35 (186.6%) stddev-sans-first:60356.49 09:24:01 INFO - PROCESS | 21374 | Values: 555.8 590.0 590.5 601.1 629.9 31628.7 32266.2 32314.2 32381.0 32399.0 35119.1 35902.0 36188.1 36226.1 36227.6 7350.3 7514.0 7515.9 7516.1 7518.8 7443.4 7540.6 7585.5 7593.9 7607.8 7515.1 7578.5 7584.9 7653.2 7657.3 7491.6 7519.3 7586.1 7589.0 7598.2 7410.3 7486.9 7487.0 7492.1 7539.5 23736.2 30473.4 30737.4 31120.0 31180.2 2685.5 2724.1 2728.5 2760.2 2777.3 24373.8 25581.0 26011.9 26694.2 26835.7 3368.8 3397.5 3516.1 3593.5 3620.9 114467.4 115240.4 115437.0 115595.4 116435.4 34233.3 34369.8 34395.1 34397.3 34538.1 41069.6 41290.6 41437.0 41537.8 44398.0 13267.3 13600.6 13635.3 13660.9 13689.0 9645.9 9649.5 9688.2 9725.5 9729.6 14749.7 14904.5 14937.3 14983.2 15766.7 5905.4 6004.5 6053.5 6059.6 6094.5 727.9 865.2 886.9 906.6 1006.6 24914.5 26055.0 26363.7 26385.7 26462.5 878.0 885.3 895.7 926.8 1002.2 12875.7 13251.3 13498.9 13506.7 13578.7 275874.0 278445.0 281277.0 282310.0 283880.0 38658.4 38679.8 38909.2 39011.4 39286.0 1096.9 1131.7 1134.8 1135.0 1173.0 22835.7 23963.4 24281.4 24350.0 24534.1 33085.2 34263.5 34386.7 34428.0 34591.5 254851.0 255417.0 258001.0 258114.0 258492.0 31452.8 32062.5 32326.7 32364.5 32518.0 34262.1 35335.0 35434.6 35480.8 35725.3 30081.7 30171.4 30324.5 30740.7 30838.0 29776.6 30012.2 30406.2 30549.8 30802.7 25024.9 27451.5 28040.7 30284.7 30634.9 25234.9 26397.6 26938.0 27042.4 27048.9 22008.8 22136.3 22467.6 22556.2 22560.8 09:24:01 INFO - PROCESS | 21374 | 09:24:01 INFO - PROCESS | 21374 | [#2] jquery.html Cycles:180 Average:21518.75 Median:4975.23 stddev:57847.81 (1162.7%) stddev-sans-first:57988.27 09:24:01 INFO - PROCESS | 21374 | Values: 359.2 367.5 368.4 371.8 381.2 14171.4 14315.0 15293.1 15295.2 15302.5 13701.7 14246.4 15128.5 15272.9 15381.9 4547.9 4969.1 5109.8 5112.8 5141.2 5043.9 5067.1 5071.7 5076.3 5086.4 4761.0 5002.7 5063.4 5069.1 5070.8 4981.4 4990.1 4992.2 5000.2 5034.7 4321.0 4500.2 4504.8 4531.5 4539.8 17483.0 17784.1 17987.2 17992.6 18171.0 1728.8 1868.3 1902.1 2026.5 2098.9 7899.8 8119.7 8123.6 8192.1 8362.6 1803.3 1828.0 1837.2 1846.0 1849.9 46875.0 49977.5 52963.5 53950.0 55215.0 8776.2 9026.0 9124.5 9362.3 9445.8 12904.3 12960.4 12986.1 13001.6 13007.7 6639.1 6667.4 6915.4 6967.5 6991.8 6400.3 6467.2 6570.2 6580.7 6620.6 4119.1 4153.6 4189.3 4243.7 4284.6 1713.6 1802.1 1815.7 1827.1 1834.4 795.5 814.0 827.8 881.2 883.6 14600.1 15025.3 15135.0 15453.5 15470.2 815.8 824.3 830.9 831.0 836.3 8524.9 8762.0 8772.5 8877.8 8893.3 344194.0 346974.0 351749.0 358031.0 360460.0 66423.0 66636.0 66841.3 67242.7 68040.7 755.6 808.9 861.6 863.0 865.0 12614.5 13306.4 13587.7 13936.3 14005.1 28470.9 29147.6 29611.1 30349.4 30735.7 38731.8 43588.3 43608.1 43780.6 44049.0 7434.8 7540.4 7639.8 7737.5 7765.4 10368.8 11165.6 11286.0 11485.3 11529.7 9608.4 9952.4 10026.9 10108.5 10328.9 9599.7 9687.8 9718.0 9772.9 10102.4 9875.5 9972.3 10023.0 10257.2 10444.3 6815.3 7242.9 7506.9 7661.3 7760.2 8524.0 9570.0 9581.4 9612.2 9716.4 09:24:01 INFO - PROCESS | 21374 | 09:24:01 INFO - PROCESS | 21374 | [#3] mootools.html Cycles:180 Average:5005.26 Median:5139.37 stddev:2843.81 (55.3%) stddev-sans-first:2838.00 09:24:01 INFO - PROCESS | 21374 | Values: 1277.9 1308.6 1317.0 1476.0 1502.8 6422.1 7148.6 7216.4 7471.5 7553.7 7132.0 7149.0 7185.6 7212.9 7228.4 2142.6 2166.1 2168.3 2169.8 2183.0 2082.9 2083.1 2184.0 2200.6 2204.1 2159.5 2161.4 2162.0 2170.5 2201.6 2068.9 2090.5 2098.5 2099.5 2109.5 2065.9 2079.6 2104.2 2106.5 2116.0 7277.5 7347.6 7405.2 7405.9 7411.1 4426.9 4562.9 4584.7 4607.4 4610.5 2860.6 2955.1 3030.3 3036.2 3047.1 886.7 905.0 912.3 949.1 949.7 10700.2 10702.4 10727.1 10744.4 10752.4 4266.3 4315.5 4324.8 4339.1 4345.3 9146.8 9152.9 9179.0 9207.8 9211.8 4499.5 4567.0 4576.2 4595.5 4600.4 3522.5 4054.1 4108.2 4190.7 4214.3 3439.0 3450.3 3550.8 3559.7 3571.3 1151.3 1153.1 1154.2 1160.4 1164.6 688.1 809.2 813.9 841.7 846.4 5206.5 5330.8 5400.4 5412.1 5418.6 374.9 379.9 382.3 391.0 396.9 3360.0 3364.3 3418.8 3439.5 3463.6 9160.7 9319.7 9450.3 9617.0 9653.5 9412.7 9494.8 9496.5 9542.5 9546.1 6942.6 6962.0 7039.4 7062.2 7079.9 5125.8 5152.9 5232.4 5233.9 5328.2 8832.6 8889.9 8909.9 8928.5 8993.9 8811.3 8897.8 8926.5 9065.0 9173.3 5395.0 6602.7 6644.4 6701.5 6839.0 7076.9 7115.6 7137.9 7140.8 7198.5 6380.9 6511.5 6523.3 6702.7 6782.8 6329.8 6338.9 6392.2 6642.1 6682.1 5996.4 6050.6 6067.5 6072.0 6073.5 4212.3 4230.8 4334.8 4385.3 4446.7 4398.5 4402.3 4499.0 4532.8 4532.9 09:24:01 INFO - PROCESS | 21374 | 09:24:01 INFO - PROCESS | 21374 | [#4] prototype.html Cycles:180 Average:4374.31 Median:4889.60 stddev:1289.67 (26.4%) stddev-sans-first:1256.33 09:24:01 INFO - PROCESS | 21374 | Values: 290.3 294.2 297.8 301.0 316.7 4729.3 4835.9 4879.5 4951.0 4968.5 4862.4 4873.4 4899.7 4912.6 4913.9 3850.5 3866.8 3884.7 3888.8 3912.4 3621.4 3867.7 3899.8 3901.2 3926.3 3817.5 3822.5 3832.5 3835.1 3844.9 3807.6 3819.8 3825.0 3828.5 3835.1 3371.5 3381.4 3381.6 3389.6 3402.8 4625.7 4740.7 4748.5 4756.7 4761.0 4320.6 4364.6 4367.5 4380.7 4395.6 5122.8 5134.0 5135.7 5163.7 5174.1 3583.8 3652.1 3659.8 3666.1 3690.7 5297.4 5351.2 5370.7 5414.3 5444.3 3706.6 3708.7 3716.8 3724.7 3728.8 3755.5 3779.7 3780.7 3782.2 3788.6 4080.5 4343.3 4345.0 4346.3 4358.1 5174.0 5175.7 5181.0 5192.4 5206.1 1304.5 1334.9 1379.5 1382.1 1384.4 904.6 924.7 931.2 940.4 941.3 4799.4 4807.4 4808.9 4832.5 4842.1 5640.4 5645.6 5665.6 5691.5 5701.5 4709.4 4801.9 4846.4 4852.0 4867.7 3028.8 3032.7 3036.3 3041.8 3050.6 5318.2 5332.5 5340.6 5341.7 5360.7 5606.2 5727.5 5762.3 5785.3 5822.1 5272.1 5315.4 5320.1 5326.6 5327.2 5511.2 5613.0 5626.3 5635.8 5649.2 5484.9 5490.9 5503.9 5506.5 5533.4 5217.6 5254.8 5262.3 5286.9 5305.6 3785.3 3872.9 3901.7 3920.6 3935.8 5077.3 5656.6 5666.9 5672.6 5682.8 4998.9 5175.9 5177.1 5181.8 5185.8 5098.9 5142.9 5143.9 5147.8 5178.6 4810.3 5041.6 5065.4 5075.2 5123.9 5171.5 5180.1 5190.5 5206.4 5217.6 5031.6 5056.7 5063.1 5098.9 5129.4 09:24:01 INFO - PROCESS | 21374 | 09:24:01 INFO - PROCESS | 21374 | [#5] yui.html Cycles:180 Average:12186.15 Median:538.00 stddev:14285.91 (2655.4%) stddev-sans-first:14299.56 09:24:01 INFO - PROCESS | 21374 | Values: 617.4 702.6 709.4 711.2 718.1 11840.5 12454.1 12672.9 13095.5 13484.2 11843.3 11927.9 11941.2 11952.2 12048.8 501.8 537.7 538.0 538.0 545.9 628.5 645.0 650.0 652.4 654.0 594.5 598.7 602.5 610.4 611.7 620.1 637.3 638.4 642.2 645.6 528.4 533.9 542.4 553.6 566.2 10978.7 11034.2 11036.8 11075.8 11077.8 10927.2 10928.5 11314.7 11817.5 12070.8 9451.9 9464.1 9496.8 9505.1 9734.0 3287.0 3308.0 3433.7 3434.0 3440.6 42898.4 43447.3 43846.6 44017.3 44189.6 8744.7 9013.8 9048.0 9107.5 9121.5 15441.1 15458.1 15496.6 15553.9 15780.2 6231.6 6287.8 6463.3 6464.0 6469.2 3528.0 3549.0 3604.9 3615.0 3695.3 2588.0 2594.2 2595.5 2623.9 2651.9 484.3 484.3 487.8 489.1 496.5 564.2 564.4 574.4 587.7 595.5 8025.4 8100.6 8217.5 8283.1 8410.7 507.9 517.1 568.8 571.5 574.8 3676.5 3765.6 3768.4 3849.2 3873.6 49801.3 49925.8 52550.5 52942.4 52992.5 45532.3 45830.0 45917.8 46909.5 48356.8 43111.8 43273.1 43312.1 43609.3 43616.6 7268.4 7440.3 7461.2 7514.7 7543.2 28230.7 29429.9 29539.9 29864.4 30239.8 35611.6 35922.6 37477.6 37523.1 38256.8 8942.2 9017.7 9139.2 9230.4 9257.8 9913.6 10103.8 10107.3 10581.7 10595.2 9654.4 9683.0 9742.6 9810.0 9895.6 9226.3 9361.9 9487.4 9595.9 9627.3 9707.6 9736.1 9827.1 9874.5 9935.9 8441.4 8519.8 8736.6 8751.3 8763.7 7762.6 8169.5 8247.5 8259.5 8276.8 09:24:01 INFO - PROCESS | 21374 | -------- Summary: end -------- 09:24:01 INFO - PROCESS | 21374 | 09:24:02 INFO - TEST-INFO | 21374: exit 0 09:24:02 INFO - TEST-OK | dromaeo_css | took 1114274ms 09:24:02 INFO - TEST-START | kraken 09:24:02 INFO - operating with platform_type : linux_ 09:24:02 INFO - Initialising browser for kraken test... 09:24:02 INFO - TEST-INFO | started process 21613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpePhYyP/profile http://localhost:57937/getInfo.html) 09:24:06 INFO - PROCESS | 21613 | 09:24:06 INFO - PROCESS | 21613 | (process:21683): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:24:07 INFO - PROCESS | 21613 | __metrics Screen width/height:1600/1200 09:24:07 INFO - PROCESS | 21613 | colorDepth:24 09:24:07 INFO - PROCESS | 21613 | Browser inner width/height: 1024/697 09:24:07 INFO - PROCESS | 21613 | __metrics 09:24:07 ERROR - PROCESS | 21613 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:24:08 INFO - TEST-INFO | 21613: exit 0 09:24:08 INFO - Browser initialized. 09:24:08 INFO - Running cycle 1/1 for kraken test... 09:24:08 INFO - TEST-INFO | started process 21734 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpePhYyP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:10 INFO - PROCESS | 21734 | 09:24:10 INFO - PROCESS | 21734 | (process:21794): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:24:20 INFO - PROCESS | 21734 | RSS: Main: 166080512 09:24:20 INFO - PROCESS | 21734 | 09:24:23 INFO - PROCESS | 21734 | Cycle 1(1): loaded http://localhost:57937/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57937/tests/kraken/driver.html?testName=audio-beat-detection) 09:24:24 INFO - PROCESS | 21734 | RSS: Main: 170135552 09:24:24 INFO - PROCESS | 21734 | 09:24:27 INFO - PROCESS | 21734 | Cycle 1(1): loaded http://localhost:57937/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57937/tests/kraken/driver.html?testName=audio-dft) 09:24:27 INFO - PROCESS | 21734 | RSS: Main: 173379584 09:24:27 INFO - PROCESS | 21734 | 09:24:30 INFO - PROCESS | 21734 | Cycle 1(1): loaded http://localhost:57937/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57937/tests/kraken/driver.html?testName=audio-fft) 09:24:31 INFO - PROCESS | 21734 | RSS: Main: 164372480 09:24:31 INFO - PROCESS | 21734 | 09:24:33 INFO - PROCESS | 21734 | Cycle 1(1): loaded http://localhost:57937/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57937/tests/kraken/driver.html?testName=audio-oscillator) 09:24:34 INFO - PROCESS | 21734 | RSS: Main: 164470784 09:24:34 INFO - PROCESS | 21734 | 09:24:36 INFO - PROCESS | 21734 | Cycle 1(1): loaded http://localhost:57937/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57937/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:24:36 INFO - PROCESS | 21734 | RSS: Main: 166174720 09:24:36 INFO - PROCESS | 21734 | 09:24:40 INFO - PROCESS | 21734 | Cycle 1(1): loaded http://localhost:57937/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57937/tests/kraken/driver.html?testName=imaging-darkroom) 09:24:40 INFO - PROCESS | 21734 | RSS: Main: 166543360 09:24:40 INFO - PROCESS | 21734 | 09:24:44 INFO - PROCESS | 21734 | Cycle 1(1): loaded http://localhost:57937/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57937/tests/kraken/driver.html?testName=imaging-desaturate) 09:24:44 INFO - PROCESS | 21734 | RSS: Main: 166014976 09:24:44 INFO - PROCESS | 21734 | 09:24:47 INFO - PROCESS | 21734 | Cycle 1(1): loaded http://localhost:57937/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57937/tests/kraken/driver.html?testName=json-parse-financial) 09:24:48 INFO - PROCESS | 21734 | RSS: Main: 166596608 09:24:48 INFO - PROCESS | 21734 | 09:24:50 INFO - PROCESS | 21734 | Cycle 1(1): loaded http://localhost:57937/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57937/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:24:50 INFO - PROCESS | 21734 | RSS: Main: 166879232 09:24:50 INFO - PROCESS | 21734 | 09:24:52 INFO - PROCESS | 21734 | Cycle 1(1): loaded http://localhost:57937/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57937/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:24:53 INFO - PROCESS | 21734 | RSS: Main: 167489536 09:24:53 INFO - PROCESS | 21734 | 09:24:55 INFO - PROCESS | 21734 | Cycle 1(1): loaded http://localhost:57937/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57937/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:24:56 INFO - PROCESS | 21734 | RSS: Main: 167424000 09:24:56 INFO - PROCESS | 21734 | 09:24:59 INFO - PROCESS | 21734 | Cycle 1(1): loaded http://localhost:57937/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:24:59 INFO - PROCESS | 21734 | RSS: Main: 167550976 09:24:59 INFO - PROCESS | 21734 | 09:25:03 INFO - PROCESS | 21734 | Cycle 1(1): loaded http://localhost:57937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:25:03 INFO - PROCESS | 21734 | RSS: Main: 165126144 09:25:03 INFO - PROCESS | 21734 | 09:25:05 INFO - PROCESS | 21734 | Cycle 1(1): loaded http://localhost:57937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57937/tests/kraken/driver.html?testName=ai-astar) 09:25:05 INFO - PROCESS | 21734 | RSS: Main: 167055360 09:25:05 INFO - PROCESS | 21734 | 09:25:05 INFO - PROCESS | 21734 | __start_tp_report 09:25:05 INFO - PROCESS | 21734 | _x_x_mozilla_page_load 09:25:05 INFO - PROCESS | 21734 | _x_x_mozilla_page_load_details 09:25:05 INFO - PROCESS | 21734 | |i|pagename|runs| 09:25:05 INFO - PROCESS | 21734 | |0;ai-astar;114;108;114;113;113;126;115;113;114;113 09:25:05 INFO - PROCESS | 21734 | |1;audio-beat-detection;163;134;166;184;142;159;158;146;198;139 09:25:05 INFO - PROCESS | 21734 | |2;audio-dft;162;165;164;171;164;162;163;163;165;164 09:25:05 INFO - PROCESS | 21734 | |3;audio-fft;77;73;74;168;75;78;73;78;153;74 09:25:05 INFO - PROCESS | 21734 | |4;audio-oscillator;94;94;147;97;94;95;149;95;94;146 09:25:06 INFO - PROCESS | 21734 | |5;imaging-gaussian-blur;118;118;117;118;118;118;118;118;118;118 09:25:06 INFO - PROCESS | 21734 | |6;imaging-darkroom;146;153;147;148;147;147;147;147;146;149 09:25:06 INFO - PROCESS | 21734 | |7;imaging-desaturate;95;96;96;96;95;96;95;96;96;95 09:25:06 INFO - PROCESS | 21734 | |8;json-parse-financial;66;65;66;66;66;65;65;87;65;63 09:25:06 INFO - PROCESS | 21734 | |9;json-stringify-tinderbox;65;65;65;64;65;65;66;65;66;65 09:25:06 INFO - PROCESS | 21734 | |10;stanford-crypto-aes;78;79;80;82;80;85;81;79;80;80 09:25:06 INFO - PROCESS | 21734 | |11;stanford-crypto-ccm;136;134;145;153;137;146;145;139;225;144 09:25:06 INFO - PROCESS | 21734 | |12;stanford-crypto-pbkdf2;220;227;216;216;222;222;221;223;221;218 09:25:06 INFO - PROCESS | 21734 | |13;stanford-crypto-sha256-iterative;73;78;75;77;74;74;74;75;74;73 09:25:06 INFO - PROCESS | 21734 | __end_tp_report 09:25:06 INFO - PROCESS | 21734 | __start_cc_report 09:25:06 INFO - PROCESS | 21734 | _x_x_mozilla_cycle_collect,937 09:25:06 INFO - PROCESS | 21734 | __end_cc_report 09:25:06 INFO - PROCESS | 21734 | __startTimestamp1461687905995__endTimestamp 09:25:06 INFO - PROCESS | 21734 | 09:25:06 INFO - PROCESS | 21734 | ------- Summary: start ------- 09:25:06 INFO - PROCESS | 21734 | Number of tests: 14 09:25:06 INFO - PROCESS | 21734 | 09:25:06 INFO - PROCESS | 21734 | [#0] ai-astar Cycles:10 Average:114.30 Median:114.00 stddev:4.52 (4.0%) stddev-sans-first:4.80 09:25:06 INFO - PROCESS | 21734 | Values: 114.0 108.0 114.0 113.0 113.0 126.0 115.0 113.0 114.0 113.0 09:25:06 INFO - PROCESS | 21734 | 09:25:06 INFO - PROCESS | 21734 | [#1] audio-beat-detection Cycles:10 Average:158.90 Median:161.00 stddev:20.26 (12.6%) stddev-sans-first:21.44 09:25:06 INFO - PROCESS | 21734 | Values: 163.0 134.0 166.0 184.0 142.0 159.0 158.0 146.0 198.0 139.0 09:25:06 INFO - PROCESS | 21734 | 09:25:06 INFO - PROCESS | 21734 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.58 (1.6%) stddev-sans-first:2.60 09:25:06 INFO - PROCESS | 21734 | Values: 162.0 165.0 164.0 171.0 164.0 162.0 163.0 163.0 165.0 164.0 09:25:06 INFO - PROCESS | 21734 | 09:25:06 INFO - PROCESS | 21734 | [#3] audio-fft Cycles:10 Average:92.30 Median:74.50 stddev:36.17 (48.5%) stddev-sans-first:37.93 09:25:06 INFO - PROCESS | 21734 | Values: 77.0 73.0 74.0 168.0 75.0 78.0 73.0 78.0 153.0 74.0 09:25:06 INFO - PROCESS | 21734 | 09:25:06 INFO - PROCESS | 21734 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:94.00 stddev:25.44 (27.1%) stddev-sans-first:26.28 09:25:06 INFO - PROCESS | 21734 | Values: 94.0 94.0 147.0 97.0 94.0 95.0 149.0 95.0 94.0 146.0 09:25:06 INFO - PROCESS | 21734 | 09:25:06 INFO - PROCESS | 21734 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:25:06 INFO - PROCESS | 21734 | Values: 118.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 09:25:06 INFO - PROCESS | 21734 | 09:25:06 INFO - PROCESS | 21734 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.00 stddev:2.06 (1.4%) stddev-sans-first:2.09 09:25:06 INFO - PROCESS | 21734 | Values: 146.0 153.0 147.0 148.0 147.0 147.0 147.0 147.0 146.0 149.0 09:25:06 INFO - PROCESS | 21734 | 09:25:06 INFO - PROCESS | 21734 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:25:06 INFO - PROCESS | 21734 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 09:25:06 INFO - PROCESS | 21734 | 09:25:06 INFO - PROCESS | 21734 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:66.00 stddev:6.95 (10.5%) stddev-sans-first:7.35 09:25:06 INFO - PROCESS | 21734 | Values: 66.0 65.0 66.0 66.0 66.0 65.0 65.0 87.0 65.0 63.0 09:25:06 INFO - PROCESS | 21734 | 09:25:06 INFO - PROCESS | 21734 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 09:25:06 INFO - PROCESS | 21734 | Values: 65.0 65.0 65.0 64.0 65.0 65.0 66.0 65.0 66.0 65.0 09:25:06 INFO - PROCESS | 21734 | 09:25:06 INFO - PROCESS | 21734 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:1.96 (2.4%) stddev-sans-first:1.87 09:25:06 INFO - PROCESS | 21734 | Values: 78.0 79.0 80.0 82.0 80.0 85.0 81.0 79.0 80.0 80.0 09:25:06 INFO - PROCESS | 21734 | 09:25:06 INFO - PROCESS | 21734 | [#11] stanford-crypto-ccm Cycles:10 Average:150.40 Median:145.00 stddev:26.83 (18.5%) stddev-sans-first:27.94 09:25:06 INFO - PROCESS | 21734 | Values: 136.0 134.0 145.0 153.0 137.0 146.0 145.0 139.0 225.0 144.0 09:25:06 INFO - PROCESS | 21734 | 09:25:06 INFO - PROCESS | 21734 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:220.60 Median:221.50 stddev:3.34 (1.5%) stddev-sans-first:3.54 09:25:06 INFO - PROCESS | 21734 | Values: 220.0 227.0 216.0 216.0 222.0 222.0 221.0 223.0 221.0 218.0 09:25:06 INFO - PROCESS | 21734 | 09:25:06 INFO - PROCESS | 21734 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:74.50 stddev:1.64 (2.2%) stddev-sans-first:1.62 09:25:06 INFO - PROCESS | 21734 | Values: 73.0 78.0 75.0 77.0 74.0 74.0 74.0 75.0 74.0 73.0 09:25:06 INFO - PROCESS | 21734 | -------- Summary: end -------- 09:25:06 INFO - PROCESS | 21734 | 09:25:06 INFO - TEST-INFO | 21734: exit 0 09:25:07 INFO - TEST-OK | kraken | took 64462ms 09:25:07 INFO - SUITE-END | took 1178s 09:25:07 INFO - Completed test suite (00:19:38) 09:25:07 INFO - javascript benchmark 09:25:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2568.589025755879, 2659.1756555467814, 2665.8400495970245, 2676.2907829425194, 2677.879495422707, 4553.977230113845, 4613.907721845561, 4622.144903192908, 4627.097715945388, 4660.953390466094, 4487.551244875511, 4581.060882519084, 4585.151746926821, 4589.036302376497, 4599.241125214336, 4169.937450938239, 4205.894852628679, 4232.936505952413, 4326.653867690593, 4338.197433474801, 4276.144771045788, 4285.0, 4315.115401342718, 4331.068820203672, 4344.543822898598, 4162.0, 4301.870943871673, 4319.611234988851, 4334.718243314174, 4370.147821174872, 4249.893752656178, 4254.638355739766, 4262.616364527176, 4270.12462445198, 4278.743275403454, 4172.102997855475, 4209.431726716915, 4274.316109422478, 4295.806688699016, 4312.37470566766, 4340.175366680321, 4443.200223959686, 4548.317752337143, 4584.174848527264, 4595.517470665599, 4852.247901575226, 4922.655414121013, 4923.532264434909, 4927.236278376858, 4936.4076310842565, 4927.426278275811, 4991.975040124777, 5008.924866127011, 5020.824271150529, 5025.396952365703, 4644.419447569054, 4652.930206046912, 4707.105649926503, 4717.080169366941, 4720.0, 5014.373203349582, 5016.44819069902, 5022.9748851256245, 5024.045431368028, 5027.597792176617, 4779.880502987453, 4792.137415265216, 4829.806807727722, 4835.709857408567, 4881.926771098437, 4761.428628564595, 4897.608191344684, 4931.852044438672, 4969.577585905166, 4982.9252561211615, 4885.682430641997, 4903.656744027955, 4920.335754673145, 4927.187014142698, 4972.602191824645, 4813.542713442287, 4914.533119353656, 4918.311436398907, 4924.901501969941, 4975.353204083446, 4190.622843944059, 4267.8079486423185, 4302.720323178984, 4324.286492728727, 4343.891402714958, 3687.870924517629, 3740.6259374062374, 3764.3412402829395, 3780.2061567070673, 3806.1626442182674, 4332.00363916301, 4343.218220720238, 4354.56454354562, 4363.5418281080665, 4402.867913962522, 4797.088553174955, 4947.035328110984, 4958.033183529177, 5024.924626130611, 5047.394312682502, 4249.68127390447, 4250.0, 4270.359446083113, 4285.10012897295, 4289.1421715657, 4414.757188354607, 4448.243798554254, 4449.065696203834, 4454.621357184676, 4505.121501307213, 4627.444706635225, 4642.419697537808, 4652.0, 4665.836695715634, 4704.764761761899, 4858.878528036827, 4916.508349165055, 4927.60579153674, 4930.630202734737, 4966.776495057803, 4584.931226031679, 4620.699654522446, 4667.369905062773, 4679.227927391942, 4709.317149013305, 4888.60891128716, 4892.2661600760175, 4892.90214195707, 4893.241547560134, 4920.360353154067, 4916.631252655993, 4918.827841025547, 4936.531029552187, 4940.925886111783, 4946.950530494649, 4689.390379250675, 4763.16644587189, 4834.951650483591, 4851.32081508582, 4874.2201247800185, 4806.735629540409, 4822.228443449031, 4827.0, 4838.250071238964, 4882.316475693477, 4747.477777444547, 4770.0936822003705, 4778.522147785194, 4791.760411979318, 4818.95181048185, 4732.408448943882, 4807.759612019315, 4866.270059491105, 4866.48901865299, 4910.582600478856, 4640.883977900579, 4717.669763116549, 4751.097291514601, 4789.377380940456, 4815.422149342101], "value": 4549.252244158702, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.7788595616292, 589.985250368741, 590.5039766596059, 601.1193601373988, 629.9496040316775, 31628.68371316286, 32266.193345166383, 32314.192145196383, 32381.0, 32399.0, 35119.122021949464, 35902.0, 36188.095297617576, 36226.10191184706, 36227.637723622756, 7350.264973502647, 7513.962430187841, 7515.887261691079, 7516.098068231792, 7518.8120296992465, 7443.367313778335, 7540.622968851563, 7585.469017168801, 7593.924060759405, 7607.771766847003, 7515.098188217422, 7578.469507134503, 7584.886226706604, 7653.1964143764935, 7657.272559106876, 7491.550506969572, 7519.323260906544, 7586.051743532059, 7588.962055189744, 7598.240175982412, 7410.2589741026, 7486.9251307486775, 7487.0, 7492.063492063492, 7539.547627142334, 23736.169234076726, 30473.39053218923, 30737.38525229505, 31120.0, 31180.220494487592, 2685.5031819113333, 2724.087430710714, 2728.4952283827356, 2760.2409337432164, 2777.319556708599, 24373.756262437328, 25580.97676092954, 26011.869940650366, 26694.19917402481, 26835.731642683517, 3368.7641865069454, 3397.524346591479, 3516.050666320105, 3593.4609808528667, 3620.945685814715, 114467.42766286198, 115240.42379788132, 115437.0, 115595.42202289018, 116435.41782291119, 34233.31533369319, 34369.82815085958, 34395.14012149716, 34397.31205375878, 34538.13654658654, 41069.58930410658, 41290.587094129274, 41437.0, 41537.792311038254, 44398.0, 13267.270300133392, 13600.59198224035, 13635.250061246727, 13660.86339136596, 13689.0, 9645.90354096464, 9649.469279189572, 9688.224942004623, 9725.513724313756, 9729.56216970238, 14749.705005899821, 14904.478343257933, 14937.327820248114, 14983.175925323994, 15766.68466630661, 5905.350411454737, 6004.489618382399, 6053.545984051214, 6059.575829691968, 6094.512439004869, 727.92362768496, 865.2472349056361, 886.8758373827669, 906.5603182456504, 1006.6023920551341, 24914.501709965698, 26055.03130612545, 26363.73636263651, 26385.73614263871, 26462.470750584882, 877.9868301975475, 885.2519620920312, 895.713371721043, 926.8146370725882, 1002.2132625888643, 12875.678108047374, 13251.271180085188, 13498.93250533741, 13506.662333441545, 13578.728425431436, 275874.0, 278445.0, 281277.0, 282310.0, 283880.0, 38658.42012369817, 38679.80660096682, 38909.22181556353, 39011.41482877759, 39286.0, 1096.8903109688968, 1131.7000994736402, 1134.8184290513477, 1134.982975255372, 1173.0263880978766, 22835.657465138367, 23963.400914977265, 24281.392965175306, 24350.0, 24534.141305054236, 33085.17287067843, 34263.486047709805, 34386.656133438344, 34428.0, 34591.481127783605, 254851.0, 255417.0, 258001.0, 258114.0, 258492.0, 31452.842735786173, 32062.519062214553, 32326.676733232365, 32364.514532281562, 32518.0, 34262.14344641404, 35335.0, 35434.645653543135, 35480.82259588789, 35725.28549428945, 30081.69918300789, 30171.396572068876, 30324.5451318226, 30740.69259307378, 30838.0, 29776.553351700175, 30012.24969375783, 30406.23984400319, 30549.847250763603, 30802.69197308088, 25024.874875625505, 27451.450970980866, 28040.71959280381, 30284.69715302907, 30634.85556011058, 25234.873825630755, 26397.60403593986, 26938.0, 27042.360438286858, 27048.864755676095, 22008.779912200673, 22136.335909922727, 22467.550648986602, 22556.210532631278, 22560.774392255866], "value": 15147.716736326553, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.2330374650121, 367.50937498439583, 368.4307744534694, 371.79922841665496, 381.19377516552464, 14171.433142674294, 14315.0, 15293.082415055076, 15295.15876626785, 15302.464413745507, 13701.65745856354, 14246.430142794276, 15128.470503532379, 15272.854535909824, 15381.923090384533, 4547.86303424144, 4969.10556099901, 5109.795608175668, 5112.846614601568, 5141.15170996785, 5043.873903152432, 5067.113255180328, 5071.695698258098, 5076.263941728447, 5086.364204474441, 4760.976195119037, 5002.7248501332415, 5063.443021267658, 5069.062223488648, 5070.847874563769, 4981.352424184869, 4990.101781679296, 4992.201247800353, 5000.224965130411, 5034.672746271499, 4320.956790432118, 4500.212462819027, 4504.752238626874, 4531.52418996004, 4539.750313732743, 17483.0, 17784.110794460226, 17987.19057642409, 17992.640147196984, 18171.0, 1728.7752592163065, 1868.2900497810745, 1902.1155162849202, 2026.4528577284198, 2098.9055492502875, 7899.842003159962, 8119.675212991473, 8123.553204573746, 8192.057913339982, 8362.623681934327, 1803.3147403986532, 1828.0494143045676, 1837.1916356803097, 1846.0, 1849.8890066595914, 46875.0, 49977.500224997646, 52963.47036529624, 53949.99999999961, 55215.0, 8776.210141087206, 9026.0, 9124.543772811465, 9362.344635875423, 9445.811083778286, 12904.29026403538, 12960.351982400842, 12986.090973631755, 13001.609951701465, 13007.674808129872, 6639.136912201383, 6667.366600172976, 6915.446764258847, 6967.54710943787, 6991.825204369829, 6400.295967443578, 6467.223933128054, 6570.244421891448, 6580.670966451658, 6620.569662971891, 4119.0937993641355, 4153.626173644387, 4189.308764053897, 4243.745375277432, 4284.592963668447, 1713.6144367517459, 1802.0809387212355, 1815.727640853856, 1827.1229809691156, 1834.3763120539081, 795.4551132474273, 813.9674413023531, 827.8302947895667, 881.2245224202661, 883.6067949762422, 14600.12399256048, 15025.323860426308, 15135.0, 15453.459128930434, 15470.226488675522, 815.7776781712261, 824.2746383182761, 830.9293710034715, 830.9626066827008, 836.2682652678906, 8524.914750852413, 8762.0, 8772.473651580925, 8877.822443551093, 8893.333000025024, 344194.0, 346974.0, 351749.0, 358031.0, 360460.0, 66423.0, 66636.0, 66841.33158668448, 67242.66378668076, 68040.65979670169, 755.6297414266969, 808.9191080891982, 861.642418396371, 863.0161615758041, 864.991350086491, 12614.49542018309, 13306.401211945293, 13587.728245435233, 13936.303184840921, 14005.089669171472, 28470.85764571247, 29147.562786558643, 29611.111666650035, 30349.393012139193, 30735.692643073282, 38731.80634096811, 43588.34617480804, 43608.12783744244, 43780.56219437892, 44049.0, 7434.788673455344, 7540.359069479156, 7639.770806875803, 7737.497062690907, 7765.41759368061, 10368.792624147625, 11165.553377864795, 11286.0, 11485.253458525503, 11529.654110376701, 9608.423494590346, 9952.402855828674, 10026.949865250626, 10108.545115469675, 10328.948355258175, 9599.712008639752, 9687.757806054906, 9718.0, 9772.9022709772, 10102.444365559964, 9875.456849873326, 9972.30193886421, 10023.047810457994, 10257.230707697101, 10444.268901177149, 6815.318468153343, 7242.855142897218, 7506.887396688945, 7661.310482056641, 7760.18518055596, 8523.95738021306, 9569.952150239482, 9581.377210481296, 9612.231021518122, 9716.368436051634], "value": 7570.050083089724, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.8849903508683, 1308.627041293231, 1316.9539066132686, 1475.9926200368996, 1502.8046353973982, 6422.068800024005, 7148.606826624534, 7216.422686185106, 7471.476996610239, 7553.735619253321, 7131.964340178305, 7148.96425517873, 7185.604791736452, 7212.855742885139, 7228.4217262618995, 2142.6250406178897, 2166.11189412341, 2168.30614203455, 2169.783021697833, 2183.0, 2082.864613800098, 2083.125087463269, 2183.9563208735817, 2200.6368949123375, 2204.129368899292, 2159.481724386144, 2161.416417567256, 2161.9567608647817, 2170.4573856535867, 2201.6147174244525, 2068.896555172243, 2090.46693093261, 2098.5383215692523, 2099.548597051626, 2109.45154259892, 2065.8863762493056, 2079.6152711748223, 2104.2424727098387, 2106.547092375147, 2116.047778499666, 7277.454190935701, 7347.6326183691135, 7405.222451642608, 7405.925940740577, 7411.0736157980255, 4426.911461770746, 4562.885927851797, 4584.724916504987, 4607.424071991001, 4610.5389461053965, 2860.5852151438135, 2955.0986948980553, 3030.3333266681293, 3036.1650546099777, 3047.085874237742, 886.7206829848642, 904.9909500905038, 912.2929729459655, 949.1410273702311, 949.6533765175731, 10700.197485188564, 10702.411367374869, 10727.08819750322, 10744.355338679705, 10752.354858708424, 4266.253405653998, 4315.482142142901, 4324.78376081201, 4339.067100573392, 4345.304751239786, 9146.81706365869, 9152.8627070594, 9179.0, 9207.769805754775, 9211.76970575741, 4499.482559505699, 4567.040921406542, 4576.176288268143, 4595.494495605481, 4600.401947746838, 3522.5244591980268, 4054.108096218886, 4108.198901214294, 4190.664746820247, 4214.304639734471, 3439.0370696205105, 3450.344434557426, 3550.840212190458, 3559.715222782171, 3571.2500374921037, 1151.3494875395374, 1153.1005815463952, 1154.1978325064, 1160.3733983648904, 1164.6214980131492, 688.0814113158889, 809.1827254473025, 813.9321359266653, 841.7433130102427, 846.3652260804397, 5206.5314121729225, 5330.840074797762, 5400.405955344909, 5412.107002344569, 5418.647787893774, 374.88940762475136, 379.87654012446063, 382.2660491855588, 390.9687225021991, 396.8710169195023, 3359.9664003360144, 3364.327134573095, 3418.777779444328, 3439.4840773883616, 3463.6363181866045, 9160.6793762218, 9319.673811416567, 9450.338476306593, 9616.95191524038, 9653.46905920181, 9412.67055653049, 9494.762630934143, 9496.47769372691, 9542.475163866055, 9546.093121153479, 6942.583444993316, 6961.965190174017, 7039.401650859734, 7062.152541694927, 7079.89380159298, 5125.846224613268, 5152.899371971866, 5232.424433312409, 5233.869153271199, 5328.200769884394, 8832.646694132163, 8889.911100888909, 8909.910900890907, 8928.464292142493, 8993.910060899307, 8811.339149563937, 8897.822043559223, 8926.509042002752, 9065.0, 9173.31200160004, 5395.0, 6602.702878370581, 6644.402003819486, 6701.530892837454, 6838.965805170942, 7076.858462830817, 7115.6086415247655, 7137.928620713934, 7140.821479463055, 7198.4601154914635, 6380.93619063822, 6511.511636627177, 6523.3476652336285, 6702.698378572878, 6782.762603308861, 6329.810105696836, 6338.904916426165, 6392.232932048184, 6642.136522252076, 6682.131322927989, 5996.430339117776, 6050.6369617823075, 6067.514598831995, 6072.0, 6073.453389194994, 4212.347086201644, 4230.767307798101, 4334.79249178606, 4385.298352263622, 4446.688731788744, 4398.494173169998, 4402.2516172251435, 4499.0, 4532.818687252473, 4532.932006019978], "value": 3954.1745276602855, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.32789093249113, 294.2247178684167, 297.79154591785755, 300.9699030096989, 316.6516831485368, 4729.29060640904, 4835.9274610880775, 4879.536139158252, 4950.950490495089, 4968.527989840968, 4862.416510018803, 4873.439554451239, 4899.657024008321, 4912.557869791718, 4913.877153071175, 3850.5379354477363, 3866.76799392036, 3884.6892248620184, 3888.8444462221546, 3912.3544615138467, 3621.4386770050683, 3867.671247943928, 3899.78551179685, 3901.239258344624, 3926.3325234710023, 3817.4655548223272, 3822.541295044585, 3832.5400951885813, 3835.1179228777396, 3844.8654297099606, 3807.619238076198, 3819.8090095495254, 3824.9808750956345, 3828.464015037897, 3835.0987517933263, 3371.494275858616, 3381.39383792699, 3381.628020917697, 3389.5593572835373, 3402.812845293508, 4625.745583992879, 4740.715557066587, 4748.548887855648, 4756.738379389132, 4761.0, 4320.611144996966, 4364.5635436456105, 4367.54140815213, 4380.715253508543, 4395.582419670126, 5122.820701275437, 5134.0, 5135.6918584885025, 5163.690178589259, 5174.120399532088, 3583.7670551414076, 3652.0889030764847, 3659.8170091495317, 3666.120131168527, 3690.6862916652117, 5297.364316282033, 5351.224072509464, 5370.731463426813, 5414.3232095988005, 5444.3194600674915, 3706.629337066272, 3708.6662200402093, 3716.758410703296, 3724.7206459515646, 3728.832202550892, 3755.511783468132, 3779.6787273081545, 3780.678642315434, 3782.205736795249, 3788.583255841855, 4080.530738965057, 4343.305071188594, 4344.956550434518, 4346.261495401802, 4358.128374325148, 5174.0, 5175.689458632494, 5180.974095129575, 5192.350956130484, 5206.114960456732, 1304.5173285884284, 1334.9065565410328, 1379.5102738527878, 1382.0671047043206, 1384.4254634326844, 904.6291020681489, 924.653255029364, 931.1852129386787, 940.3746508571724, 941.2799208605422, 4799.448063472745, 4807.423109226916, 4808.927866082012, 4832.4684284728655, 4842.128416884924, 5640.407757185519, 5645.633033852787, 5665.631733937281, 5691.4877661010705, 5701.486866182064, 4709.3877795887, 4801.927971080437, 4846.400687773026, 4852.0295940811975, 4867.659263851497, 3028.8485575721566, 3032.6815684353264, 3036.3320069584656, 3041.847907604611, 3050.633923929143, 5318.228856815817, 5332.466753324637, 5340.572754179656, 5341.65279256847, 5360.678359298455, 5606.206014075457, 5727.5131613812455, 5762.279715035621, 5785.334686511105, 5822.097574875901, 5272.103742363807, 5315.388730295988, 5320.084769482983, 5326.627136100436, 5327.200919862052, 5511.200875873056, 5612.971935140298, 5626.2685850839125, 5635.802746903839, 5649.248732892816, 5484.945150548443, 5490.862728431821, 5503.9174412383045, 5506.476884695948, 5533.363663178625, 5217.6086793491395, 5254.842354729364, 5262.315898933267, 5286.8942621148135, 5305.628605997543, 3785.312428176026, 3872.8838134856, 3901.6878649708524, 3920.6471417572557, 3935.803209839554, 5077.339945807022, 5656.604037717485, 5666.886662266649, 5672.602917795714, 5682.829515114553, 4998.900021999612, 5175.870603234949, 5177.145770947752, 5181.792728290826, 5185.818496352609, 5098.923516147335, 5142.948570514247, 5143.92284115731, 5147.819826306061, 5178.559822415137, 4810.278458231153, 5041.6470847040355, 5065.39215294167, 5075.213341932006, 5123.948760512347, 5171.456997015259, 5180.057478445583, 5190.506901844319, 5206.375234971828, 5217.634765566374, 5031.572316353151, 5056.7471626419265, 5063.088644044107, 5098.872528186825, 5129.410117836496], "value": 3966.134362545879, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.4103730936954, 702.6100514214612, 709.3686618909169, 711.2176605733692, 718.0736849464191, 11840.526378944842, 12454.128211025232, 12672.873271267285, 13095.47618095275, 13484.190948543095, 11843.348615826126, 11927.940360298186, 11941.164118511708, 11952.163348565604, 12048.7590248195, 501.75414047116834, 537.6747068023848, 537.9623426360147, 538.0422847331756, 545.912653975364, 628.4595248086641, 644.9613023218599, 649.9545031847773, 652.363945153474, 653.9705713242892, 594.5392320951254, 598.706633749464, 602.4698265526331, 610.3774150366623, 611.7430679114782, 620.0791824141147, 637.2639601260528, 638.399904090156, 642.2293248102296, 645.6190847400034, 528.3633221967519, 533.938597061339, 542.3627237995379, 553.573748213873, 566.2497191221648, 10978.670639880816, 11034.227604067719, 11036.834447483294, 11075.833862491989, 11077.778444431147, 10927.235093543455, 10928.453577321103, 11314.717132071682, 11817.527298908033, 12070.758584828342, 9451.858222126673, 9464.148226659565, 9496.810063798754, 9505.144536991704, 9734.0, 3286.967130328714, 3307.9503807442907, 3433.7081348085444, 3434.038469228595, 3440.6043305019994, 42898.35652465184, 43447.348289775364, 43846.561534384884, 44017.339739903924, 44189.558104419186, 8744.69393571222, 9013.774655633662, 9048.049954754788, 9107.499087550115, 9121.45271283725, 15441.0735355879, 15458.149801760786, 15496.612584685248, 15553.922230388776, 15780.210989450481, 6231.626102433868, 6287.805316989758, 6463.289038205794, 6463.967680161569, 6469.223693156757, 3527.982360088183, 3548.9645103548633, 3604.8738294160103, 3614.98192509041, 3695.316366472211, 2588.0, 2594.2347007632793, 2595.493878693637, 2623.8819253133656, 2651.8862077927315, 484.2832607740493, 484.3292040523829, 487.7561219390305, 489.06100287448186, 496.5183771741405, 564.1847530318651, 564.3932772269744, 574.3882764855416, 587.7011803913399, 595.5414330965133, 8025.398095142771, 8100.594970251464, 8217.506949583045, 8283.08886022537, 8410.747677569683, 507.92888995540653, 517.0770175237259, 568.7724910036019, 571.4999375546397, 574.8045664474099, 3676.485292059114, 3765.642263984917, 3768.4347347897487, 3849.2301539692176, 3873.5932727063814, 49801.25298120531, 49925.75037124791, 52550.47449525532, 52942.35288235573, 52992.47007529953, 45532.3170152448, 45830.0, 45917.7704111484, 46909.53090469052, 48356.75821620869, 43111.784441077594, 43273.13453730908, 43312.13375732468, 43609.34585981213, 43616.56383436125, 7268.418526517971, 7440.2931721486375, 7461.179270280373, 7514.661840217313, 7543.207963163789, 28230.71769282363, 29429.852850736464, 29539.85230073836, 29864.402711945204, 30239.848800755855, 35611.643883560835, 35922.640773592975, 37477.62522374741, 37523.06192345213, 38256.80871595624, 8942.239909607497, 9017.729468115967, 9139.177474027369, 9230.35387522867, 9257.814843702954, 9913.55389007482, 10103.848442273225, 10107.292489525662, 10581.682549523526, 10595.15238780911, 9654.372465789702, 9682.951585242028, 9742.610295588098, 9810.0, 9895.604175833174, 9226.308026897876, 9361.906380936376, 9487.350693671473, 9595.904040959502, 9627.277954153607, 9707.563159657691, 9736.123748862636, 9827.11555959967, 9874.456904870302, 9935.900640993497, 8441.36689748259, 8519.829603407774, 8736.563171841255, 8751.256143227896, 8763.737087887373, 7762.5730584818375, 8169.5098294102545, 8247.505149691038, 8259.504429734236, 8276.793080173044], "value": 5425.663406605554, "unit": "score"}], "name": "dromaeo_css", "value": 5950.464040600512, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 114.0, 113.0, 113.0, 126.0, 115.0, 113.0, 114.0, 113.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 134.0, 166.0, 184.0, 142.0, 159.0, 158.0, 146.0, 198.0, 139.0], "value": 158.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 164.0, 171.0, 164.0, 162.0, 163.0, 163.0, 165.0, 164.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 74.0, 168.0, 75.0, 78.0, 73.0, 78.0, 153.0, 74.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 147.0, 97.0, 94.0, 95.0, 149.0, 95.0, 94.0, 146.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 153.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 149.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 87.0, 65.0, 63.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 80.0, 82.0, 80.0, 85.0, 81.0, 79.0, 80.0, 80.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 145.0, 153.0, 137.0, 146.0, 145.0, 139.0, 225.0, 144.0], "value": 150.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [220.0, 227.0, 216.0, 216.0, 222.0, 222.0, 221.0, 223.0, 221.0, 218.0], "value": 220.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 75.0, 77.0, 74.0, 74.0, 74.0, 75.0, 74.0, 73.0], "value": 74.7, "unit": "score"}], "name": "kraken", "value": 1660.1, "alertThreshold": 2.0}]} 09:25:07 INFO - Return code: 0 09:25:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:25:07 ERROR - # TBPL SUCCESS # 09:25:07 INFO - Running post-action listener: _resource_record_post_action 09:25:07 INFO - Running post-run listener: _resource_record_post_run 09:25:08 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 537907200; Read time: 0; Write time: 485128 09:25:08 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241864704; Read time: 0; Write time: 311288 09:25:08 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 296042496; Read time: 0; Write time: 173840 09:25:08 INFO - Running post-run listener: _upload_blobber_files 09:25:08 INFO - Blob upload gear active. 09:25:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:25:08 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 09:25:08 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'] 09:25:08 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 09:25:08 INFO - (blobuploader) - INFO - Open directory for files ... 09:25:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:25:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:25:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:09 INFO - (blobuploader) - INFO - Done attempting. 09:25:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:25:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:25:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:10 INFO - (blobuploader) - INFO - Done attempting. 09:25:10 INFO - (blobuploader) - INFO - Iteration through files over. 09:25:10 INFO - Return code: 0 09:25:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:25:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:25:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93a8a24f59eddd51dae97b4cd375217035798072a9c51deb8c1320be46ec722a02799861554b7a2a2cbdb2c352cfc92db2d3c039bc6da078223883246b668699", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0822657f9dbdebfc90c5df10a5867a8dc6e12698f2cccbe40e02c9e85927ef35d983d0c578885288c2776b5c5f1e602130aaeeffd8f6ac8e23696b38fb0b7260"} 09:25:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:25:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:25:10 INFO - Contents: 09:25:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93a8a24f59eddd51dae97b4cd375217035798072a9c51deb8c1320be46ec722a02799861554b7a2a2cbdb2c352cfc92db2d3c039bc6da078223883246b668699", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0822657f9dbdebfc90c5df10a5867a8dc6e12698f2cccbe40e02c9e85927ef35d983d0c578885288c2776b5c5f1e602130aaeeffd8f6ac8e23696b38fb0b7260"} 09:25:10 INFO - Running post-run listener: copy_logs_to_upload_dir 09:25:10 INFO - Copying logs to upload dir... 09:25:10 INFO - mkdir: /builds/slave/test/build/upload/logs 09:25:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.960629 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-26 09:25:10.157163) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 09:25:10.160804) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357 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/93a8a24f59eddd51dae97b4cd375217035798072a9c51deb8c1320be46ec722a02799861554b7a2a2cbdb2c352cfc92db2d3c039bc6da078223883246b668699", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0822657f9dbdebfc90c5df10a5867a8dc6e12698f2cccbe40e02c9e85927ef35d983d0c578885288c2776b5c5f1e602130aaeeffd8f6ac8e23696b38fb0b7260"} build_url:https://queue.taskcluster.net/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/fwAUbEz0QR2xfmWO6vk2Jw/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/93a8a24f59eddd51dae97b4cd375217035798072a9c51deb8c1320be46ec722a02799861554b7a2a2cbdb2c352cfc92db2d3c039bc6da078223883246b668699", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0822657f9dbdebfc90c5df10a5867a8dc6e12698f2cccbe40e02c9e85927ef35d983d0c578885288c2776b5c5f1e602130aaeeffd8f6ac8e23696b38fb0b7260"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 09:25:10.191132) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 09:25:10.191619) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461686569.466594-1034814357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 09:25:10.277144) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 09:25:10.277628) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 09:25:10.278019) ========= ========= Total master_lag: 0.18 =========