builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1461330507.71 results: success (0) buildid: 20160419230832 builduid: 1ab072c2db0d4b259b7f46e10e93ac05 revision: d42b25947fc26a0f9eab98d631465b72769553bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:27.705840) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:27.706304) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:27.706591) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:27.722645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:27.722968) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 06:08:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-04-22 06:08:28 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137617 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:27.875483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:27.876029) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015980 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:27.927390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:27.928007) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d42b25947fc26a0f9eab98d631465b72769553bd --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 d42b25947fc26a0f9eab98d631465b72769553bd --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=e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 06:08:28,284 truncating revision to first 12 chars 2016-04-22 06:08:28,284 Setting DEBUG logging. 2016-04-22 06:08:28,284 attempt 1/10 2016-04-22 06:08:28,284 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d42b25947fc2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 06:08:28,574 unpacking tar archive at: fx-team-d42b25947fc2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.553729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:28.495455) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:28.495778) ========= script_repo_revision: d42b25947fc26a0f9eab98d631465b72769553bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:28.496201) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:28.496472) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:08:28.504747) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-22 06:08:28.505135) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:08:28 INFO - MultiFileLogger online at 20160422 06:08:28 in /builds/slave/test 06:08:28 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 06:08:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:08:28 INFO - {'append_to_log': False, 06:08:28 INFO - 'base_work_dir': '/builds/slave/test', 06:08:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:08:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:08:28 INFO - 'branch': 'Fx-Team-Non-PGO', 06:08:28 INFO - 'buildbot_json_path': 'buildprops.json', 06:08:28 INFO - 'config_files': ('talos/linux_config.py',), 06:08:28 INFO - 'default_actions': ('clobber', 06:08:28 INFO - 'read-buildbot-config', 06:08:28 INFO - 'download-and-extract', 06:08:28 INFO - 'populate-webroot', 06:08:28 INFO - 'create-virtualenv', 06:08:28 INFO - 'install', 06:08:28 INFO - 'run-tests'), 06:08:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:08:28 INFO - 'download_minidump_stackwalk': True, 06:08:28 INFO - 'download_symbols': 'ondemand', 06:08:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:08:28 INFO - 'tooltool.py': '/tools/tooltool.py', 06:08:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:08:28 INFO - '/tools/misc-python/virtualenv.py')}, 06:08:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:08:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:08:28 INFO - 'installer_path': 'installer.exe', 06:08:28 INFO - 'log_level': 'info', 06:08:28 INFO - 'log_name': 'talos', 06:08:28 INFO - 'log_to_console': True, 06:08:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:08:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:08:28 INFO - 'opt_config_files': (), 06:08:28 INFO - 'pip_index': False, 06:08:28 INFO - 'sps_profile': False, 06:08:28 INFO - 'sps_profile_interval': 0, 06:08:28 INFO - 'suite': 'dromaeojs-e10s', 06:08:28 INFO - 'system_bits': '32', 06:08:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:08:28 INFO - 'title': 'talos-linux64-ix-006', 06:08:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:08:28 INFO - 'use_talos_json': True, 06:08:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:08:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:08:28 INFO - 'work_dir': 'build'} 06:08:28 INFO - ##### 06:08:28 INFO - ##### Running clobber step. 06:08:28 INFO - ##### 06:08:28 INFO - Running pre-action listener: _resource_record_pre_action 06:08:28 INFO - Running main action method: clobber 06:08:28 INFO - rmtree: /builds/slave/test/build 06:08:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:08:29 INFO - Running post-action listener: _resource_record_post_action 06:08:29 INFO - ##### 06:08:29 INFO - ##### Running read-buildbot-config step. 06:08:29 INFO - ##### 06:08:29 INFO - Running pre-action listener: _resource_record_pre_action 06:08:29 INFO - Running main action method: read_buildbot_config 06:08:29 INFO - Using buildbot properties: 06:08:29 INFO - { 06:08:29 INFO - "project": "", 06:08:29 INFO - "product": "firefox", 06:08:29 INFO - "script_repo_revision": "production", 06:08:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:08:29 INFO - "repository": "", 06:08:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 06:08:29 INFO - "buildid": "20160419230832", 06:08:29 INFO - "pgo_build": "False", 06:08:29 INFO - "basedir": "/builds/slave/test", 06:08:29 INFO - "buildnumber": 1190, 06:08:29 INFO - "slavename": "talos-linux64-ix-006", 06:08:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:08:29 INFO - "platform": "ubuntu64_hw", 06:08:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:08:29 INFO - "branch": "fx-team", 06:08:29 INFO - "repo_path": "integration/fx-team", 06:08:29 INFO - "revision": "d42b25947fc26a0f9eab98d631465b72769553bd", 06:08:29 INFO - "stage_platform": "linux64", 06:08:29 INFO - "builduid": "1ab072c2db0d4b259b7f46e10e93ac05", 06:08:29 INFO - "slavebuilddir": "test" 06:08:29 INFO - } 06:08:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 06:08:29 INFO - Running post-action listener: _resource_record_post_action 06:08:29 INFO - ##### 06:08:29 INFO - ##### Running download-and-extract step. 06:08:29 INFO - ##### 06:08:29 INFO - Running pre-action listener: _resource_record_pre_action 06:08:29 INFO - Running main action method: download_and_extract 06:08:29 INFO - mkdir: /builds/slave/test/build/tests 06:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:29 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:08:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:08:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:08:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:08:30 INFO - Downloaded 1361 bytes. 06:08:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:08:30 INFO - Using the following test package requirements: 06:08:30 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:08:30 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:08:30 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:08:30 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:30 INFO - u'jsshell-linux-x86_64.zip'], 06:08:30 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:08:30 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:08:30 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:08:30 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:08:30 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:08:30 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:08:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:08:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:30 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:08:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:08:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:08:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:08:32 INFO - Downloaded 22267191 bytes. 06:08:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:08:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:08:33 INFO - Return code: 0 06:08:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:33 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:08:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:08:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:08:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:08:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:08:35 INFO - Downloaded 22267191 bytes. 06:08:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:08:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:08:36 INFO - Return code: 0 06:08: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')]} 06:08:36 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:08:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:08:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:08:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:08:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:08:37 INFO - Downloaded 10845952 bytes. 06:08:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:08:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:08:37 INFO - Return code: 0 06:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:37 INFO - https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:08:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:08:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:08:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:08:38 INFO - Downloaded 54589518 bytes. 06:08:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:08:38 INFO - mkdir: /builds/slave/test/properties 06:08:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:08:38 INFO - Writing to file /builds/slave/test/properties/build_url 06:08:38 INFO - Contents: 06:08:38 INFO - build_url:https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:08:39 INFO - Running post-action listener: _resource_record_post_action 06:08:39 INFO - Running post-action listener: set_extra_try_arguments 06:08:39 INFO - ##### 06:08:39 INFO - ##### Running populate-webroot step. 06:08:39 INFO - ##### 06:08:39 INFO - Running pre-action listener: _resource_record_pre_action 06:08:39 INFO - Running main action method: populate_webroot 06:08:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:08:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:08:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:08:39 INFO - '--tppagecycles', 06:08:39 INFO - '7'], 06:08:39 INFO - 'tests': ['tsvgm']}}, 06:08:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:08:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:08:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:08:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:08:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:08:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:08:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:39 INFO - 'talos_options': ['--disable-e10s'], 06:08:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:08:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:08:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:39 INFO - 'talos_options': ['--disable-e10s'], 06:08:39 INFO - 'tests': ['damp', 'tps']}, 06:08:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:39 INFO - 'tests': ['damp', 'tps']}, 06:08:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:08:39 INFO - 'tests': ['dromaeo_dom']}, 06:08:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:08:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:08:39 INFO - 'tests': ['a11yr', 06:08:39 INFO - 'ts_paint', 06:08:39 INFO - 'tpaint', 06:08:39 INFO - 'sessionrestore', 06:08:39 INFO - 'sessionrestore_no_auto_restore', 06:08:39 INFO - 'tabpaint']}, 06:08:39 INFO - 'other-e10s': {'tests': ['a11yr', 06:08:39 INFO - 'ts_paint', 06:08:39 INFO - 'tpaint', 06:08:39 INFO - 'sessionrestore', 06:08:39 INFO - 'sessionrestore_no_auto_restore', 06:08:39 INFO - 'tabpaint']}, 06:08:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:08:39 INFO - 'ts_paint', 06:08:39 INFO - 'tpaint', 06:08:39 INFO - 'sessionrestore', 06:08:39 INFO - 'sessionrestore_no_auto_restore', 06:08:39 INFO - 'tabpaint']}, 06:08:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:08:39 INFO - 'ts_paint', 06:08:39 INFO - 'tpaint', 06:08:39 INFO - 'sessionrestore', 06:08:39 INFO - 'sessionrestore_no_auto_restore', 06:08:39 INFO - 'tabpaint']}, 06:08:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:08:39 INFO - 'tests': ['a11yr', 06:08:39 INFO - 'ts_paint', 06:08:39 INFO - 'tpaint', 06:08:39 INFO - 'sessionrestore', 06:08:39 INFO - 'sessionrestore_no_auto_restore', 06:08:39 INFO - 'tabpaint']}, 06:08:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:08:39 INFO - 'tests': ['a11yr', 06:08:39 INFO - 'ts_paint', 06:08:39 INFO - 'tpaint', 06:08:39 INFO - 'sessionrestore', 06:08:39 INFO - 'sessionrestore_no_auto_restore', 06:08:39 INFO - 'tabpaint']}, 06:08:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:08:39 INFO - 'tests': ['tsvgx', 06:08:39 INFO - 'tsvgr_opacity', 06:08:39 INFO - 'tart', 06:08:39 INFO - 'tscrollx', 06:08:39 INFO - 'cart']}, 06:08:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:08:39 INFO - 'tsvgr_opacity', 06:08:39 INFO - 'tart', 06:08:39 INFO - 'tscrollx', 06:08:39 INFO - 'cart']}, 06:08:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:39 INFO - 'talos_options': ['--disable-e10s'], 06:08:39 INFO - 'tests': ['tp5o']}, 06:08:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:39 INFO - 'tests': ['tp5o']}, 06:08:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:39 INFO - 'talos_options': ['--disable-e10s', 06:08:39 INFO - '--xperf_path', 06:08:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:08:39 INFO - 'tests': ['tp5n']}, 06:08:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:39 INFO - 'talos_options': ['--xperf_path', 06:08:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:08:39 INFO - 'tests': ['tp5n']}}, 06:08:39 INFO - 'talos.zip': {'path': '', 06:08:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:08:39 INFO - Running post-action listener: _resource_record_post_action 06:08:39 INFO - ##### 06:08:39 INFO - ##### Running create-virtualenv step. 06:08:39 INFO - ##### 06:08:39 INFO - Running pre-action listener: _resource_record_pre_action 06:08:39 INFO - Running main action method: create_virtualenv 06:08:39 INFO - Creating virtualenv /builds/slave/test/build/venv 06:08:39 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 06:08:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:08:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:08:39 INFO - Using real prefix '/usr' 06:08:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:08:40 INFO - Installing distribute.............................................................................................................................................................................................done. 06:08:42 INFO - Installing pip.................done. 06:08:42 INFO - Return code: 0 06:08:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:08: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')]} 06:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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')]} 06:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:42 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 0x7fea6f3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9410>, '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 0x1dca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', '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 06:08:42 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 06:08:42 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 06:08:42 INFO - Using env: {'DISPLAY': ':0', 06:08:42 INFO - 'HOME': '/home/cltbld', 06:08:42 INFO - 'LANG': 'en_US.UTF-8', 06:08:42 INFO - 'LANGUAGE': 'en_US:en', 06:08:42 INFO - 'LOGNAME': 'cltbld', 06:08:42 INFO - 'MAIL': '/var/mail/cltbld', 06:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:42 INFO - 'MOZ_NO_REMOTE': '1', 06:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:42 INFO - 'NO_EM_RESTART': '1', 06:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:42 INFO - 'PWD': '/builds/slave/test', 06:08:42 INFO - 'SHELL': '/bin/bash', 06:08:42 INFO - 'SHLVL': '1', 06:08:42 INFO - 'TERM': 'linux', 06:08:42 INFO - 'TMOUT': '86400', 06:08:42 INFO - 'USER': 'cltbld', 06:08:42 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', 06:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:42 INFO - '_': '/tools/buildbot/bin/python'} 06:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:42 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 06:08:42 INFO - Cleaning up... 06:08:42 INFO - Return code: 0 06:08:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:08: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')]} 06:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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')]} 06:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:42 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 0x7fea6f3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9410>, '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 0x1dca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', '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 06:08:42 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 06:08:42 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 06:08:42 INFO - Using env: {'DISPLAY': ':0', 06:08:42 INFO - 'HOME': '/home/cltbld', 06:08:42 INFO - 'LANG': 'en_US.UTF-8', 06:08:42 INFO - 'LANGUAGE': 'en_US:en', 06:08:42 INFO - 'LOGNAME': 'cltbld', 06:08:42 INFO - 'MAIL': '/var/mail/cltbld', 06:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:42 INFO - 'MOZ_NO_REMOTE': '1', 06:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:42 INFO - 'NO_EM_RESTART': '1', 06:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:42 INFO - 'PWD': '/builds/slave/test', 06:08:42 INFO - 'SHELL': '/bin/bash', 06:08:42 INFO - 'SHLVL': '1', 06:08:42 INFO - 'TERM': 'linux', 06:08:42 INFO - 'TMOUT': '86400', 06:08:42 INFO - 'USER': 'cltbld', 06:08:42 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', 06:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:42 INFO - '_': '/tools/buildbot/bin/python'} 06:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:42 INFO - Downloading/unpacking psutil>=0.7.1 06:08:42 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 06:08:42 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 06:08:42 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 06:08:42 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 06:08:42 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 06:08:42 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 06:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:08:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:08:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:08:44 INFO - Installing collected packages: psutil 06:08:44 INFO - Running setup.py install for psutil 06:08:44 INFO - building 'psutil._psutil_linux' extension 06:08:44 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 06:08:45 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 06:08:45 INFO - building 'psutil._psutil_posix' extension 06:08:45 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 06:08:45 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 06:08:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:08:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:08:45 INFO - Successfully installed psutil 06:08:45 INFO - Cleaning up... 06:08:45 INFO - Return code: 0 06:08:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:45 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 0x7fea6f3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9410>, '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 0x1dca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', '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 06:08:45 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 06:08:45 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 06:08:45 INFO - Using env: {'DISPLAY': ':0', 06:08:45 INFO - 'HOME': '/home/cltbld', 06:08:45 INFO - 'LANG': 'en_US.UTF-8', 06:08:45 INFO - 'LANGUAGE': 'en_US:en', 06:08:45 INFO - 'LOGNAME': 'cltbld', 06:08:45 INFO - 'MAIL': '/var/mail/cltbld', 06:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:45 INFO - 'MOZ_NO_REMOTE': '1', 06:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:45 INFO - 'NO_EM_RESTART': '1', 06:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:45 INFO - 'PWD': '/builds/slave/test', 06:08:45 INFO - 'SHELL': '/bin/bash', 06:08:45 INFO - 'SHLVL': '1', 06:08:45 INFO - 'TERM': 'linux', 06:08:45 INFO - 'TMOUT': '86400', 06:08:45 INFO - 'USER': 'cltbld', 06:08:45 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', 06:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:45 INFO - '_': '/tools/buildbot/bin/python'} 06:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:08:47 INFO - Installing collected packages: mozsystemmonitor 06:08:47 INFO - Running setup.py install for mozsystemmonitor 06:08:47 INFO - Successfully installed mozsystemmonitor 06:08:47 INFO - Cleaning up... 06:08:47 INFO - Return code: 0 06:08:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:08:47 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')]} 06:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:47 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')]} 06:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:47 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 0x7fea6f3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9410>, '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 0x1dca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', '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 06:08:47 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 06:08:47 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 06:08:47 INFO - Using env: {'DISPLAY': ':0', 06:08:47 INFO - 'HOME': '/home/cltbld', 06:08:47 INFO - 'LANG': 'en_US.UTF-8', 06:08:47 INFO - 'LANGUAGE': 'en_US:en', 06:08:47 INFO - 'LOGNAME': 'cltbld', 06:08:47 INFO - 'MAIL': '/var/mail/cltbld', 06:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:47 INFO - 'MOZ_NO_REMOTE': '1', 06:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:47 INFO - 'NO_EM_RESTART': '1', 06:08:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:47 INFO - 'PWD': '/builds/slave/test', 06:08:47 INFO - 'SHELL': '/bin/bash', 06:08:47 INFO - 'SHLVL': '1', 06:08:47 INFO - 'TERM': 'linux', 06:08:47 INFO - 'TMOUT': '86400', 06:08:47 INFO - 'USER': 'cltbld', 06:08:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', 06:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:47 INFO - '_': '/tools/buildbot/bin/python'} 06:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:47 INFO - Downloading/unpacking blobuploader==1.2.4 06:08:47 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 06:08:47 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 06:08:47 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 06:08:47 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 06:08:47 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 06:08:47 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 06:08:49 INFO - Downloading blobuploader-1.2.4.tar.gz 06:08:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:08:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:08: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 06:08: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 06:08: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 06:08: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 06:08: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 06:08: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 06:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:08:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:08:50 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 06:08:50 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 06:08:50 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 06:08:50 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 06:08:50 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 06:08:50 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 06:08:50 INFO - Downloading docopt-0.6.1.tar.gz 06:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:08:50 INFO - Installing collected packages: blobuploader, requests, docopt 06:08:50 INFO - Running setup.py install for blobuploader 06:08:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:08:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:08:50 INFO - Running setup.py install for requests 06:08:51 INFO - Running setup.py install for docopt 06:08:51 INFO - Successfully installed blobuploader requests docopt 06:08:51 INFO - Cleaning up... 06:08:51 INFO - Return code: 0 06:08:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08:51 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')]} 06:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:51 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')]} 06:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:51 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 0x7fea6f3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9410>, '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 0x1dca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', '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 06:08:51 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 06:08:51 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 06:08:51 INFO - Using env: {'DISPLAY': ':0', 06:08:51 INFO - 'HOME': '/home/cltbld', 06:08:51 INFO - 'LANG': 'en_US.UTF-8', 06:08:51 INFO - 'LANGUAGE': 'en_US:en', 06:08:51 INFO - 'LOGNAME': 'cltbld', 06:08:51 INFO - 'MAIL': '/var/mail/cltbld', 06:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:51 INFO - 'MOZ_NO_REMOTE': '1', 06:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:51 INFO - 'NO_EM_RESTART': '1', 06:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:51 INFO - 'PWD': '/builds/slave/test', 06:08:51 INFO - 'SHELL': '/bin/bash', 06:08:51 INFO - 'SHLVL': '1', 06:08:51 INFO - 'TERM': 'linux', 06:08:51 INFO - 'TMOUT': '86400', 06:08:51 INFO - 'USER': 'cltbld', 06:08:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', 06:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:51 INFO - '_': '/tools/buildbot/bin/python'} 06:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:08:51 INFO - Running setup.py (path:/tmp/pip-BlnvFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:08:51 INFO - Running setup.py (path:/tmp/pip-C9bsQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:08:51 INFO - Running setup.py (path:/tmp/pip-nrPfXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:08:51 INFO - Running setup.py (path:/tmp/pip-TAZ12h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:08:51 INFO - Running setup.py (path:/tmp/pip-RH31nW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:08:51 INFO - Running setup.py (path:/tmp/pip-SqbbGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:08:51 INFO - Running setup.py (path:/tmp/pip-Va9y9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:08:51 INFO - Running setup.py (path:/tmp/pip-yx9G1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:08:52 INFO - Running setup.py (path:/tmp/pip-z89isr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:08:52 INFO - Running setup.py (path:/tmp/pip-3O2Bhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:08:52 INFO - Running setup.py (path:/tmp/pip-R5cNBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:08:52 INFO - Running setup.py (path:/tmp/pip-hTnI4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:08:52 INFO - Running setup.py (path:/tmp/pip-plWDEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:08:52 INFO - Running setup.py (path:/tmp/pip-It1UfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:52 INFO - Running setup.py (path:/tmp/pip-JM4fdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:08:52 INFO - Running setup.py (path:/tmp/pip-nO8ctG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:08:52 INFO - Running setup.py (path:/tmp/pip-MIWoXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:08:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:08:52 INFO - Running setup.py install for manifestparser 06:08:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:08:52 INFO - Running setup.py install for mozcrash 06:08:52 INFO - Running setup.py install for mozdebug 06:08:52 INFO - Running setup.py install for mozdevice 06:08:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:08:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:08:53 INFO - Running setup.py install for mozfile 06:08:53 INFO - Running setup.py install for mozhttpd 06:08:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:08:53 INFO - Running setup.py install for mozinfo 06:08:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:08:53 INFO - Running setup.py install for mozInstall 06:08:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:08:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:08:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:08:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:08:53 INFO - Running setup.py install for mozleak 06:08:53 INFO - Running setup.py install for mozlog 06:08:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:08:53 INFO - Running setup.py install for moznetwork 06:08:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:08:53 INFO - Running setup.py install for mozprocess 06:08:53 INFO - Running setup.py install for mozprofile 06:08:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:08:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:08:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:08:54 INFO - Running setup.py install for mozrunner 06:08:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:08:54 INFO - Running setup.py install for mozscreenshot 06:08:54 INFO - Running setup.py install for moztest 06:08:54 INFO - Running setup.py install for mozversion 06:08:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:08:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:08:54 INFO - Cleaning up... 06:08:54 INFO - Return code: 0 06:08:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08: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')]} 06:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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')]} 06:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:54 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 0x7fea6f3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9410>, '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 0x1dca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', '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 06:08:54 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 06:08:54 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 06:08:54 INFO - Using env: {'DISPLAY': ':0', 06:08:54 INFO - 'HOME': '/home/cltbld', 06:08:54 INFO - 'LANG': 'en_US.UTF-8', 06:08:54 INFO - 'LANGUAGE': 'en_US:en', 06:08:54 INFO - 'LOGNAME': 'cltbld', 06:08:54 INFO - 'MAIL': '/var/mail/cltbld', 06:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:54 INFO - 'MOZ_NO_REMOTE': '1', 06:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:54 INFO - 'NO_EM_RESTART': '1', 06:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:54 INFO - 'PWD': '/builds/slave/test', 06:08:54 INFO - 'SHELL': '/bin/bash', 06:08:54 INFO - 'SHLVL': '1', 06:08:54 INFO - 'TERM': 'linux', 06:08:54 INFO - 'TMOUT': '86400', 06:08:54 INFO - 'USER': 'cltbld', 06:08:54 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', 06:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:54 INFO - '_': '/tools/buildbot/bin/python'} 06:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:08:54 INFO - Running setup.py (path:/tmp/pip-IZGK4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:08:54 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)) 06:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:08:54 INFO - Running setup.py (path:/tmp/pip-PVsGnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:08:54 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)) 06:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:08:54 INFO - Running setup.py (path:/tmp/pip-Nb2RLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:08:54 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)) 06:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:08:54 INFO - Running setup.py (path:/tmp/pip-Jn9Jw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:08:54 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)) 06:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:08:54 INFO - Running setup.py (path:/tmp/pip-LJir56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:08:55 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)) 06:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:08:55 INFO - Running setup.py (path:/tmp/pip-KEiKnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:08:55 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)) 06:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:08:55 INFO - Running setup.py (path:/tmp/pip-mCT5kM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:08:55 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)) 06:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:08:55 INFO - Running setup.py (path:/tmp/pip-Kq7TLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:08:55 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)) 06:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:08:55 INFO - Running setup.py (path:/tmp/pip-hxjQqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:08:55 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)) 06:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:08:55 INFO - Running setup.py (path:/tmp/pip-eTs8lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:08:55 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)) 06:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:08:55 INFO - Running setup.py (path:/tmp/pip-fcbJSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:08:55 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)) 06:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:08:55 INFO - Running setup.py (path:/tmp/pip-4VNlgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:08:55 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)) 06:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:08:55 INFO - Running setup.py (path:/tmp/pip-VrSgxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:08:55 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)) 06:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:08:55 INFO - Running setup.py (path:/tmp/pip-sGOI4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:08:55 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)) 06:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:55 INFO - Running setup.py (path:/tmp/pip-lhmjNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:55 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)) 06:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:08:55 INFO - Running setup.py (path:/tmp/pip-4XKNtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:08:55 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)) 06:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:08:55 INFO - Running setup.py (path:/tmp/pip-9TuSkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:08:55 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)) 06:08:55 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)) 06:08:55 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)) 06:08:55 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)) 06:08:55 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)) 06:08:55 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)) 06:08:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:57 INFO - Downloading blessings-1.6.tar.gz 06:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:08:57 INFO - Installing collected packages: blessings 06:08:57 INFO - Running setup.py install for blessings 06:08:57 INFO - Successfully installed blessings 06:08:57 INFO - Cleaning up... 06:08:58 INFO - Return code: 0 06:08:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:08:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:08:58 INFO - Reading from file tmpfile_stdout 06:08:58 INFO - Current package versions: 06:08:58 INFO - argparse == 1.2.1 06:08:58 INFO - blessings == 1.6 06:08:58 INFO - blobuploader == 1.2.4 06:08:58 INFO - docopt == 0.6.1 06:08:58 INFO - manifestparser == 1.1 06:08:58 INFO - mozInstall == 1.12 06:08:58 INFO - mozcrash == 0.17 06:08:58 INFO - mozdebug == 0.1 06:08:58 INFO - mozdevice == 0.48 06:08:58 INFO - mozfile == 1.2 06:08:58 INFO - mozhttpd == 0.7 06:08:58 INFO - mozinfo == 0.9 06:08:58 INFO - mozleak == 0.1 06:08:58 INFO - mozlog == 3.1 06:08:58 INFO - moznetwork == 0.27 06:08:58 INFO - mozprocess == 0.22 06:08:58 INFO - mozprofile == 0.28 06:08:58 INFO - mozrunner == 6.11 06:08:58 INFO - mozscreenshot == 0.1 06:08:58 INFO - mozsystemmonitor == 0.0 06:08:58 INFO - moztest == 0.7 06:08:58 INFO - mozversion == 1.4 06:08:58 INFO - psutil == 3.1.1 06:08:58 INFO - requests == 1.2.3 06:08:58 INFO - wsgiref == 0.1.2 06:08:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08: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')]} 06:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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')]} 06:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:58 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 0x7fea6f3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9410>, '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 0x1dca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', '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 06:08:58 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 06:08:58 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 06:08:58 INFO - Using env: {'DISPLAY': ':0', 06:08:58 INFO - 'HOME': '/home/cltbld', 06:08:58 INFO - 'LANG': 'en_US.UTF-8', 06:08:58 INFO - 'LANGUAGE': 'en_US:en', 06:08:58 INFO - 'LOGNAME': 'cltbld', 06:08:58 INFO - 'MAIL': '/var/mail/cltbld', 06:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:58 INFO - 'MOZ_NO_REMOTE': '1', 06:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:58 INFO - 'NO_EM_RESTART': '1', 06:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:58 INFO - 'PWD': '/builds/slave/test', 06:08:58 INFO - 'SHELL': '/bin/bash', 06:08:58 INFO - 'SHLVL': '1', 06:08:58 INFO - 'TERM': 'linux', 06:08:58 INFO - 'TMOUT': '86400', 06:08:58 INFO - 'USER': 'cltbld', 06:08:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', 06:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:58 INFO - '_': '/tools/buildbot/bin/python'} 06:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:58 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)) 06:08:58 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)) 06:08:58 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)) 06:08:58 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)) 06:08:58 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)) 06:08:58 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)) 06:08:58 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)) 06:08:58 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)) 06:08:58 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)) 06:08:58 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)) 06:08:58 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)) 06:08:58 INFO - Cleaning up... 06:08:58 INFO - Return code: 0 06:08:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:08: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')]} 06:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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')]} 06:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea6f3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9410>, '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 0x1dca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', '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 06:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:08:58 INFO - Using env: {'DISPLAY': ':0', 06:08:58 INFO - 'HOME': '/home/cltbld', 06:08:58 INFO - 'LANG': 'en_US.UTF-8', 06:08:58 INFO - 'LANGUAGE': 'en_US:en', 06:08:58 INFO - 'LOGNAME': 'cltbld', 06:08:58 INFO - 'MAIL': '/var/mail/cltbld', 06:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:58 INFO - 'MOZ_NO_REMOTE': '1', 06:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:58 INFO - 'NO_EM_RESTART': '1', 06:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:58 INFO - 'PWD': '/builds/slave/test', 06:08:58 INFO - 'SHELL': '/bin/bash', 06:08:58 INFO - 'SHLVL': '1', 06:08:58 INFO - 'TERM': 'linux', 06:08:58 INFO - 'TMOUT': '86400', 06:08:58 INFO - 'USER': 'cltbld', 06:08:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', 06:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:58 INFO - '_': '/tools/buildbot/bin/python'} 06:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:58 INFO - Downloading/unpacking jsonschema 06:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:09:00 INFO - Downloading/unpacking functools32 (from jsonschema) 06:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:00 INFO - Downloading functools32-3.2.3-2.tar.gz 06:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:09:00 INFO - warning: no files found matching '*.txt' 06:09:00 INFO - no previously-included directories found matching 'build' 06:09:00 INFO - no previously-included directories found matching 'dist' 06:09:00 INFO - no previously-included directories found matching '.git*' 06:09:00 INFO - Installing collected packages: jsonschema, functools32 06:09:00 INFO - Running setup.py install for functools32 06:09:01 INFO - warning: no files found matching '*.txt' 06:09:01 INFO - no previously-included directories found matching 'build' 06:09:01 INFO - no previously-included directories found matching 'dist' 06:09:01 INFO - no previously-included directories found matching '.git*' 06:09:01 INFO - Successfully installed jsonschema functools32 06:09:01 INFO - Cleaning up... 06:09:01 INFO - Return code: 0 06:09:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:09: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')]} 06:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09: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')]} 06:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:01 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 0x7fea6f3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc9410>, '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 0x1dca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca7a0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', '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 06:09:01 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 06:09:01 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 06:09:01 INFO - Using env: {'DISPLAY': ':0', 06:09:01 INFO - 'HOME': '/home/cltbld', 06:09:01 INFO - 'LANG': 'en_US.UTF-8', 06:09:01 INFO - 'LANGUAGE': 'en_US:en', 06:09:01 INFO - 'LOGNAME': 'cltbld', 06:09:01 INFO - 'MAIL': '/var/mail/cltbld', 06:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:01 INFO - 'MOZ_NO_REMOTE': '1', 06:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:01 INFO - 'NO_EM_RESTART': '1', 06:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:01 INFO - 'PWD': '/builds/slave/test', 06:09:01 INFO - 'SHELL': '/bin/bash', 06:09:01 INFO - 'SHLVL': '1', 06:09:01 INFO - 'TERM': 'linux', 06:09:01 INFO - 'TMOUT': '86400', 06:09:01 INFO - 'USER': 'cltbld', 06:09:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', 06:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:01 INFO - '_': '/tools/buildbot/bin/python'} 06:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:01 INFO - Downloading/unpacking flake8 06:09:01 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 06:09:01 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 06:09:01 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 06:09:01 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 06:09:01 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 06:09:01 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 06:09:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:09:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:09:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:09:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:09:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:09:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:09:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:09:03 INFO - no previously-included directories found matching 'docs/_build' 06:09:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:09:04 INFO - Running setup.py install for pep8 06:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:09:04 INFO - no previously-included directories found matching 'docs/_build' 06:09:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:09:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:09:04 INFO - Cleaning up... 06:09:04 INFO - Return code: 0 06:09:04 INFO - Running post-action listener: _resource_record_post_action 06:09:04 INFO - Running post-action listener: _start_resource_monitoring 06:09:04 INFO - Starting resource monitoring. 06:09:04 INFO - ##### 06:09:04 INFO - ##### Running install step. 06:09:04 INFO - ##### 06:09:04 INFO - Running pre-action listener: _resource_record_pre_action 06:09:04 INFO - Running main action method: install 06:09:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:09:04 INFO - Reading from file tmpfile_stdout 06:09:04 INFO - Detecting whether we're running mozinstall >=1.0... 06:09:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:09:04 INFO - Reading from file tmpfile_stdout 06:09:04 INFO - Output received: 06:09:04 INFO - Usage: mozinstall [options] installer 06:09:04 INFO - Options: 06:09:04 INFO - -h, --help show this help message and exit 06:09:04 INFO - -d DEST, --destination=DEST 06:09:04 INFO - Directory to install application into. [default: 06:09:04 INFO - "/builds/slave/test"] 06:09:04 INFO - --app=APP Application being installed. [default: firefox] 06:09:04 INFO - mkdir: /builds/slave/test/build/application 06:09:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:09:20 INFO - Reading from file tmpfile_stdout 06:09:20 INFO - Output received: 06:09:20 INFO - /builds/slave/test/build/application/firefox/firefox 06:09:20 INFO - Running post-action listener: _resource_record_post_action 06:09:20 INFO - ##### 06:09:20 INFO - ##### Running run-tests step. 06:09:20 INFO - ##### 06:09:20 INFO - Running pre-action listener: _resource_record_pre_action 06:09:20 INFO - Running main action method: run_tests 06:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:09:20 INFO - Python 2.7.3 06:09:20 INFO - Return code: 0 06:09:20 INFO - grabbing minidump binary from tooltool 06:09:20 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')]} 06:09:20 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 0x1dc9410>, '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 0x1dca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dca7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:09:20 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 06:09:20 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 06:09:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:09:20 INFO - Return code: 0 06:09:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:09:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:09:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:09:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:09:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:09:21 INFO - Return code: 0 06:09:21 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/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 06:09:21 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/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 06:09:21 INFO - Using env: {'DISPLAY': ':0', 06:09:21 INFO - 'HOME': '/home/cltbld', 06:09:21 INFO - 'LANG': 'en_US.UTF-8', 06:09:21 INFO - 'LANGUAGE': 'en_US:en', 06:09:21 INFO - 'LOGNAME': 'cltbld', 06:09:21 INFO - 'MAIL': '/var/mail/cltbld', 06:09:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:09:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:21 INFO - 'MOZ_NO_REMOTE': '1', 06:09:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:09:21 INFO - 'NO_EM_RESTART': '1', 06:09:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:21 INFO - 'PWD': '/builds/slave/test', 06:09:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:09:21 INFO - 'SHELL': '/bin/bash', 06:09:21 INFO - 'SHLVL': '1', 06:09:21 INFO - 'TERM': 'linux', 06:09:21 INFO - 'TMOUT': '86400', 06:09:21 INFO - 'USER': 'cltbld', 06:09:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267', 06:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:21 INFO - '_': '/tools/buildbot/bin/python'} 06:09:21 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/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 06:09:21 INFO - mozversion application_buildid: 20160419230832 06:09:21 INFO - mozversion application_changeset: d42b25947fc26a0f9eab98d631465b72769553bd 06:09:21 INFO - mozversion application_display_name: Nightly 06:09:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:09:21 INFO - mozversion application_name: Firefox 06:09:21 INFO - mozversion application_remotingname: firefox 06:09:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:09:21 INFO - mozversion application_vendor: Mozilla 06:09:21 INFO - mozversion application_version: 48.0a1 06:09:21 INFO - mozversion platform_buildid: 20160419230832 06:09:21 INFO - mozversion platform_changeset: d42b25947fc26a0f9eab98d631465b72769553bd 06:09:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:09:21 INFO - mozversion platform_version: 48.0a1 06:09:21 INFO - using testdate: 1461330561 06:09:21 INFO - actual date: 1461330561 06:09:21 INFO - starting webserver on 'localhost:58721' 06:09:21 INFO - SUITE-START | Running 2 tests 06:09:21 INFO - TEST-START | dromaeo_css 06:09:21 INFO - operating with platform_type : linux_ 06:09:21 INFO - Initialising browser for dromaeo_css test... 06:09:21 INFO - TEST-INFO | started process 23275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsrz_bs/profile http://localhost:58721/getInfo.html) 06:09:25 INFO - PROCESS | 23275 | 06:09:25 INFO - PROCESS | 23275 | (process:23340): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:09:26 INFO - PROCESS | 23275 | __metrics Screen width/height:1600/1200 06:09:26 INFO - PROCESS | 23275 | colorDepth:24 06:09:26 INFO - PROCESS | 23275 | Browser inner width/height: 1024/697 06:09:26 INFO - PROCESS | 23275 | __metrics 06:09:26 ERROR - PROCESS | 23275 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:09:27 INFO - TEST-INFO | 23275: exit 0 06:09:27 INFO - Browser initialized. 06:09:27 INFO - Running cycle 1/1 for dromaeo_css test... 06:09:27 INFO - TEST-INFO | started process 23392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsrz_bs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:09:29 INFO - PROCESS | 23392 | 06:09:29 INFO - PROCESS | 23392 | (process:23452): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:09:39 INFO - PROCESS | 23392 | RSS: Main: 163864576 06:09:39 INFO - PROCESS | 23392 | 06:10:29 INFO - PROCESS | 23392 | 1461330629144 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] 06:12:40 INFO - PROCESS | 23392 | Cycle 1(1): loaded http://localhost:58721/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58721/tests/dromaeo/cssquery-ext.html) 06:12:42 INFO - PROCESS | 23392 | RSS: Main: 166658048 06:12:42 INFO - PROCESS | 23392 | 06:15:44 INFO - PROCESS | 23392 | Cycle 1(1): loaded http://localhost:58721/tests/dromaeo/cssquery-ext.html (next: http://localhost:58721/tests/dromaeo/cssquery-jquery.html) 06:15:44 INFO - PROCESS | 23392 | RSS: Main: 165314560 06:15:44 INFO - PROCESS | 23392 | 06:18:46 INFO - PROCESS | 23392 | Cycle 1(1): loaded http://localhost:58721/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58721/tests/dromaeo/cssquery-mootools.html) 06:18:47 INFO - PROCESS | 23392 | RSS: Main: 166424576 06:18:47 INFO - PROCESS | 23392 | 06:21:49 INFO - PROCESS | 23392 | Cycle 1(1): loaded http://localhost:58721/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58721/tests/dromaeo/cssquery-prototype.html) 06:21:49 INFO - PROCESS | 23392 | RSS: Main: 164372480 06:21:49 INFO - PROCESS | 23392 | 06:24:52 INFO - PROCESS | 23392 | Cycle 1(1): loaded http://localhost:58721/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58721/tests/dromaeo/cssquery-yui.html) 06:24:53 INFO - PROCESS | 23392 | RSS: Main: 165761024 06:24:53 INFO - PROCESS | 23392 | 06:27:55 INFO - PROCESS | 23392 | Cycle 1(1): loaded http://localhost:58721/tests/dromaeo/cssquery-yui.html (next: http://localhost:58721/tests/dromaeo/cssquery-dojo.html) 06:27:55 INFO - PROCESS | 23392 | RSS: Main: 167505920 06:27:55 INFO - PROCESS | 23392 | 06:27:55 INFO - PROCESS | 23392 | __start_tp_report 06:27:55 INFO - PROCESS | 23392 | _x_x_mozilla_page_load 06:27:55 INFO - PROCESS | 23392 | _x_x_mozilla_page_load_details 06:27:55 INFO - PROCESS | 23392 | |i|pagename|runs| 06:27:55 INFO - PROCESS | 23392 | |0;dojo.html;2602.8568428736417;2660.747229013243;2697.7032526422095;2705.7429544193296;2720.1023662191465;4682.46151692555;4719.480857105716;4742.834000809972;4743.573078422941;4793.520647935209;4618.630509559235;4706.435227772664;4710.2228132358205;4792.089502994429;4814.7351895645725;4311.396404503372;4320.567943205678;4364.127174565084;4375.7529104205305;4405.691601587891;4332.458442694663;4431.401760762305;4454.799534020977;4455.019895622958;4475.082608065355;4211.7472951623;4333.761643109628;4367.9344809828035;4397.384366188736;4440.02319489715;4337.783110844445;4347.782610869475;4360.6293465055505;4389.648828093745;4400.823967041314;4333.978330108361;4352.977050393155;4362.934555981663;4367.650587952956;4407.977960110179;4612.100640375128;4631.258998560214;4672.672912896099;4682.6253899687945;4695.084458530588;5019.67372120811;5025.221090730943;5038.470960549126;5041.823536176216;5110.310108135392;4867.342908707315;5065.392152941634;5090;5110.948890511085;5144.099782538041;4729.148753224418;4747.145513807548;4754.643401744883;4805.255185446262;4810.8797280068275;5129.461406552333;5169.638125331191;5170.1727723564045;5183.0670479314085;5223.634345595848;4803.807847686124;4966.826161084345;4971.676841005323;4977.303177555145;5012.423571289349;5009.398872135367;5035.169197082514;5049.82325618609;5072.9746351268;5084.339035925306;4849.587785038311;4938.358013458227;4941.901161976741;4945.604351651859;4967.105920934194;4941;4993.475685053089;4996.350474438373;5050.116229659795;5055.823046193365;4163.5836416358125;4254.744715317091;4264.509581398117;4264.552222016706;4334.068175342317;3762.172322089136;3763.5671897732113;3765.0399148217575;3800.315943130263;3804.8287827047848;4397.164538737629;4406.911861762746;4409.889752756143;4416.337549367557;4419.248727716296;4844;4938.703677779345;5095.210242412358;5150.356205474316;5173.405058418255;4382.145481631052;4384.386185933972;4415.337699345124;4421.5578442156175;4449.9555004450185;4565.041341318294;4566.794494247767;4571.474280457724;4572.1312950539295;4644.396228490342;4659.697119687209;4804.687695299935;4809.44691360498;4819.325294458778;4864.902701946012;5062.848114556569;5092.694438333712;5120.283160357479;5132.30713853625;5153.6907785532985;4796.712197268175;4827.493113223201;4829.879253018703;4844.273358996179;4869.074875773592;4822.807087716452;4988.077205716954;5066;5094.853657926937;5096.0827051131155;4967.25491176312;4985.252212168204;4985.52637499437;4992.201247800334;5066.771995260296;4858.975705121452;4863.221884498464;4868.440129385166;4876.4392094909535;4923.409190896972;4770.475247722818;4890.828820991248;4932.506749325039;4940.407151141886;4955.925661115159;4720.221163507983;4757.857264282077;4782.52174782519;4800.35195248651;4834.154023046023;4790.5448982346625;4915;4920.827771027997;4928.088303663833;4967.503249675148;4856.732879691651;4930.408350997904;4942.1598328285;4984.6261530384645;4989.900201996013 06:27:55 INFO - PROCESS | 23392 | |1;ext.html;573.8938296415164;599.7990673124503;613.0926229180815;622.2999125983271;643.2088531106741;32079.310879248893;32859.178520536996;33123.83438082809;33135.502967455475;33145;33544.66455335446;34157.48763768545;34390.312193756174;34427.82786086066;34464.31071378571;7482.6258687065565;7638.694452221905;7644.388448924073;7650.579218143;7661.425393095512;7479.102507699084;7683.462157648967;7710.7686769397005;7717.112532058801;7726.8454630907345;7681.807954801119;7704.229577042279;7749.883751743729;7756.3794896408435;7759.495632783851;7656.425768067389;7696.653650585709;7697.884531732028;7716.9614151929445;7726.575038372887;7610.65752041154;7699.923000769976;7745.728899488491;7750.883736743954;7783.143854176036;31109.68890311113;35076;35260.47109293363;35284;35547.28905421903;2881.2652773542823;2937.3537821679197;2966.569847372119;3184.2357834119875;3482.8432720527635;23840.642390363984;23950.401239969142;24340.26979190627;24342.513149737082;24718.25845224646;3120.1731541141617;3122.2350524121507;3199.152224660467;3210.181403742031;3221.0014895382506;165561;167289;167719;169082;169241.3075869238;32290.83854580712;32503.51244731331;32522;32626.510602340983;32633.51049734256;33260.667393325755;33388.83305583456;58694.41305586975;59805.10292345619;60747.69626151841;11996.220245684002;12021.939890300668;12038.87961120395;12159.331236781885;12167.330796806084;10356.896431035744;10588.682339529827;10617.469126543796;10617.84073238902;10652.62715804943;18371.173297201658;18458;18626;18670.626587468174;18755.812441875405;6918.5502942308585;6969.386480069974;6990.755323563651;7034.2262351141335;7215.428362960368;849.7408290471342;868.9435186712969;976.9169620582188;978.0708327089294;1065.0521036277719;27624;27755.722442775717;28309;28536.714632853407;28694.569581456293;957.5643082397493;979;1032.7779527401644;1098.8681358236902;1103.4041617526607;14856.62858428548;15220.467283645019;15384.692306153815;15495.45765898188;15520.767188492182;351313;361038;361250;362269;364248;49235.50764492381;49542.256866147036;49875.25187122196;49877;50101.99796004059;1233.0875152387168;1247.9563215287603;1269.2955409747494;1270.0855384123417;1280.6158152554383;26269;27571.586426204023;27756.167314980583;27909.860450697615;27924.72075279221;42371.364429534195;42528.362074568286;42595.5740442604;42735.14529709326;42932.35601465918;316539;316871;319387;319713;321295;25817.09640162585;26230;26350.341241469116;26387.60418593684;39174.21651566896;36708;37721.434178486794;37854.62145378511;37927.62072379241;38395.80802095972;34266.657333426345;34509.48235776415;34676.65323346734;34884.651153489154;34894;33775.83112084424;34198;34218.657813421545;34308.82845585756;34696.653033469345;31395.37209255848;34629;35059;35095;36876.26247475089;28429.857850710614;29466;29470.410591787615;29583.556246656746;30037.54943675803;22613.43466413353;23520.176793812134;24383.75616243815;24728.505429891662;24990.37524061913 06:27:55 INFO - PROCESS | 23392 | |2;jquery.html;378.9658930696237;382.5887171290863;385.25260993672276;385.89387918322456;386.37600275554985;15360.231988400577;15949.441769538054;16664;16775.83224167758;16832.990020598758;9849.409035457878;10555.577776888915;10584.78830423393;10601.840972385402;10613.57545698173;4650.883727906812;4825.107355139293;4860.513948605147;5161.509656582619;5303.893922121555;5259.658122222062;5290.312259406272;5292.708901010443;5293.04725149473;5306.416294207634;4671.509491503394;4860.270959356108;5196.454372290912;5201.143414906234;5252.789888404459;4783.210770222909;4822.710637361734;4836.854894353175;4838.951610483903;4851.102546028996;4479.686421950465;4650.325702773079;4700.576948074689;4724.362211101526;4730.219513780222;12273.20224185434;12278.877211227862;12331.753364932742;12448.75102497954;12468.81296780549;1843.7050071988551;1933.680942644462;1937.7480927479337;1980.1683293016968;2026.8581199316054;9023.278137748965;9057.456552606798;9218.677346292914;9398.812023759487;9490.288228382899;1517.8254500732446;1753.2373417563401;1763.4885883093887;1815.682255605264;1831.6829211048034;63368.683156583924;67258.32741672569;67590;69243.30756692469;70539.64730176418;9597;9915.454649994319;9954.701358959242;10023.448710321003;10118.848217276747;13928.094673846168;13961.581152565439;14031.579052628438;14039.929800350932;14054.086484378482;6814.318568143146;6894.13823272091;7137.2149063602965;7215.819604509929;7239.348458638748;6606.504512161511;6633.038209459602;6653.2681405045405;6656.30108838565;6724.226713927863;4278.828846846153;4336.82652693895;4347.739135651807;4362.0839623679385;4441.822327106945;1821.5992481654016;1825.8813177143443;1838.7405669036536;1851.7963024067342;1855.3413538194018;879.5558243087328;885.9822803543893;893.1425831201989;893.2050475077186;908.2643059122132;15413.768793468107;15696.843031569766;16048.03711777297;16212.513624591282;16337.918310408371;893.8346405914926;918.7611221082433;930.7068273493828;942.9764255893657;952.1335584617964;8949.478588639817;9074.546272686472;9141.77145571366;9160.770980725536;9317.953410232905;370082;375531;385211;389125;394132;69072.6546367265;70105.2989470109;73935.63032184912;74130.629346854;75849.24150758421;985.9950700246596;991.7570195302197;1018.6943916825071;1063.9734006649896;1081.389015206406;14623.488177913721;14663.853361466248;14669.92665036668;14811.333489993192;14876.702465950837;31200.21999450032;31229.531557027116;31693.841530792197;33321.66678333186;34171.4874276891;45481;46178.307325390815;46213.53786462092;46353.768231158625;46445.303320449544;7477.626118693935;7720.575368354795;7737.883931741141;7858.528488290721;7866.685332586632;10813.62152324665;11351.54593816238;11656.53373865036;11669.533218671158;11773.76452470963;9929.900700992897;10049.598016079275;10395.58417663285;10410;10436.165106791286;9970.651027214013;10049.69850904474;10141.695749127539;10281.794364112526;10407.58369665205;10047.698569042941;10159.7460063499;10217.795644086927;10226.795464090825;10530.894691053298;6769.593824370553;7108.964455177898;7271.563706177646;7275.6362181889635;7770.106437759504;7763.844723105619;9786.657466988621;10110.241731870286;10149.594016239267;10409.375437473776 06:27:55 INFO - PROCESS | 23392 | |3;mootools.html;1462.188485390608;1487.5314276003057;1637.2632315458047;1780.7417924400954;1802.0899445779887;7044.753433629824;7692.730754423596;7783;7893.13175550689;7932.405069619773;7831.1385747567865;7835.138134805167;7841.098273698526;7890.763277101696;7940.9205907940905;2266.1841736974716;2286.6798648189265;2290.770922907704;2294.8623082615013;2305.4121199094207;2249.5275992041693;2255.605269077913;2276.1009401286483;2278.737945136314;2284.737255215655;2232.174095584636;2250.3473992542145;2251.0545570860195;2263.671767593698;2265.7394399644004;2203.449137715571;2207.724034495688;2207.8896055197256;2208.757036725951;2219.422950033003;2218.267971569378;2228.765979572154;2229.052652622629;2234.497238121426;2236.8434209605334;7975.521468711896;8036.557989310586;8040.477368970998;8068.233517815798;8075.596220189026;4640.257558790611;4763.833265835714;4809.278608208761;4811.302361157647;4814.205656066745;2844.1894060192953;2914.635670541182;2944.455275773989;2963.4221326841275;2981.344104297051;859.2824991132412;861.8233262181237;866.1641515937151;868.274990383031;892.7009451833643;10340.224483163793;10642.680719578348;10662;10735.516901739362;10785.83821242682;4128.174365126986;4191.91616167675;4229.111886503869;4298.20483210607;4310.7629080400875;8572.442791218551;8589.141085891486;8599.269062129664;8603.01065377477;8615.310775137974;4598.425196850394;4604.171249175113;4604.677672562889;4612.838550650778;4637.559431853969;3799.430085487199;4271.615554600101;4274.743515389025;4283.850065247701;4393.340998850134;3479.8956031319103;3564.8752293669595;3622.945655815165;3632.2917031178667;3640.1263696713127;1106.950187241576;1112.9888701112886;1119.1774046076127;1119.339589642115;1122.7473818390797;728.66481418547;740.193189423531;826.6775957376628;857.7341024282492;859.6002858670748;5359.866003349947;5363.19552067193;5368.7047212403695;5392.272043274186;5406.918896216481;960.3181740963994;975.317277905469;1003.5734812704571;1009.9697009089739;1010.6664800615779;3555.1645363339594;3568.3220188164164;3583.3191693578137;3611.638836116367;3619.3485172668647;9336;9404.482753448627;9596.808063838684;9598.280128990353;9713.417194968184;9538.380005299634;9629.807403852024;9670.854937175947;9792.657256996114;9824.754381140387;7381.66782494789;7492.175860655324;7552.471327007057;7554.093508778872;7631.1987241341085;5573.749181286771;5575.637583557056;5674.375818660027;5859.206367321716;5898.35118136996;8666.566671666518;8997.820043599222;9025.954870225607;9109.134632209929;9118.680846170351;8859.778505537413;9000.414973026733;9094.863577046217;9237.12247336502;9239.538023098683;6219;6618.404343609098;6904.067950826574;6949.166100068024;7087.114110736158;7573.166951635426;7596.392288616787;7635.961820190863;7642.235776422535;7655.311022008046;6801.965990170018;7097.609631470319;7107.786766397016;7183.748568800067;7214.422846172399;7033.226345101933;7074.575525468488;7077.292270772881;7135.108111486064;7157.7136914522835;6418.293987661447;6525.673716314071;6651.733930642914;6664.533482656361;6665.0668906352175;4711.81152753886;4722.527747225387;4726.976365118152;4736;4790.808367665254;4609.907801844011;4625.468071171724;4638.536146385334;4650.093231819898;4705.694129881546 06:27:55 INFO - PROCESS | 23392 | |4;prototype.html;315.2166865339631;316.9745872103744;320.70174737494136;322.3343795063193;324.8473217587734;5245.186996015615;5245.947540524594;5250.238715386276;5252.395974462938;5256.605754568403;5184.766685499152;5198.428172900978;5217.921731174036;5224.7387630618505;5242.973785131078;3853.5183102112237;3963.365861462167;4101.138760860208;4113.115680128772;4114.753114813106;4097.7541347519245;4098.426220329156;4101.0772576170275;4102;4137.66898648109;4098.610631989956;4107.917841643165;4120.25835349637;4129.318662420697;4138;4025.838966441339;4027.456293400383;4091.0795071108764;4102.138550904314;4122.855700050513;3604.981975090134;3611.981940090309;3629.401148810443;3640.854365825364;3656.7257455690665;4999.12515309823;5007.69953802773;5033.144365457881;5042.092423363793;5044.167712327461;4603.378543896564;4675.111728771522;4696.178168820477;4734.739589322586;4737.218358970766;5469.726513674301;5476.863078423071;5480.945190548123;5507.862303442406;5513.228148059275;3939.4484772131923;3952.505936757905;3966.682665386762;3973.205358928197;3977.1449138435373;5544.584156188262;5736.541076713895;5769.07694768835;5790.652560846363;5796.449337312949;4020.4974378202724;4044.6359827615656;4050.7569545826755;4064.634182923551;4065.1869626074904;4101.097758493127;4110.815013324408;4111.465509483748;4129.731567448106;4138.8344466221615;4694.50707675696;4699.929501057487;4702.741349225757;4719.5752382285755;4724.480307166209;5280.867978300574;5580.414056524088;5589.301337332833;5594.720263986785;5604.8038318658655;1389.4095009620871;1404.7401230772136;1407.2049292149902;1409.4221369238562;1415.8230221222348;850.6852464588018;904.5929331800716;938.4979036215592;956.1012648110753;957.4781743949565;4720.221163507983;4732.195526760459;4762.761861906891;4771.5467030632035;4782.402199725035;5597.636153650081;5613.101903695389;5614.466625670637;5619.100943848965;5630.493255606933;4670;4737.905241895142;4755.167845627071;4756.857294281177;4763.69036012658;3017.2456885778556;3022.863971121305;3035.2867076237067;3041.376517813843;3045.7411120055044;5256.710880901511;5292.735363231823;5294.470552944675;5323.281357016831;5334.626576139711;5626.2685850839125;5739.569532285095;5765.682887441231;5769.221155144086;5770.336411312753;5276.709780962084;5286.444923283;5299.602529810357;5307.840764777063;5311.070562651521;5500.862478437911;5626.24045753818;5634.577406694432;5644.6330988485615;5653.773849045992;5453.918191227214;5460.3720572133125;5495.120780675233;5512.751926163252;5525.419830917856;5281.445448228034;5289.523942845162;5308.761105750174;5308.840734777963;5317.734113294242;3743.419769935664;3927.783971881574;3935.5277366716177;3941.2117576485393;3942.72400931932;5687.20379146928;5714.200011998407;5720.3707592164;5723.167032318862;5724.914126288026;5511.807086751945;5529.281193444826;5530.944690553043;5553.583481238842;5573.972130139324;5337.893242135058;5467.7266136692215;5521.2270282161335;5532.336119665666;5537.640053396516;5413.323334583177;5421.756020978986;5425.674459532441;5439.782408703608;5455.781768729206;5300.31095957523;5369;5490.5607551395;5569.496236016334;5569.526590239713;5392.487713667196;5435.483629055233;5436.565074793928;5436.836894893159;5447.727613619382 06:27:55 INFO - PROCESS | 23392 | |5;yui.html;619.8481372063843;675.1926284851859;696.3106524540704;697.1842943755805;712.579578048951;11422.31466112034;11515.654530364092;11610;11665.650030499088;11672.1829471937;10544.683659490209;11562.59530916418;11590.768184636303;11756.470958806853;11762.470688819003;630.7130255733653;793.8729803231485;800.371708209056;804.5293503300547;805.3396215103588;774.6281784743327;804.2480280937314;805.6414895371562;809.3727361295014;810.1857633078747;808.720991258018;840.0968958369747;847.9576021198947;848.6902280667574;851.7955690634266;799.2806474173233;822.2106777493614;835.131463278193;835.51122593283;836.6109758962051;588.8204097750184;595.6783336998016;616.6300219868089;618.0636335951037;618.3074956049209;11754.353510556915;11806.940965295204;11814.17300788945;11820.940895295469;11841.052715782716;11724.882751172465;11847;11955.282683039046;12148.635540933787;12166.57416990401;11221.438928053565;11261.324320540794;11274.492647830786;11435;11473.541058357656;3947.960520394788;3966.8809935701975;4014.759114453142;4105;4114.794260287003;43252.134957300994;43297;43436.78281608572;45472.54527454716;45916.770416148036;9545.52272386378;9754.561044753003;10028.849567256497;10046.547905344278;10066.094051535398;17408.912955435142;17422.912885435493;17520.912395438198;17523.474295771146;17629.118544072746;5813.883722325614;6006.759729610854;6078.331383547807;6260.342664020303;6315.621062736251;3232.4828027515487;3288.079337785424;3345.1469875181674;3359.5296658467832;3412.7440441966455;2617.332580192077;2688.623592697024;2707.9323016924736;2708.7291270873147;2714.185744276709;486.1079918349797;509.8827269727983;519.8934218485201;520.3235793468476;533.7358007786094;551.5918220516869;571.1660974976497;580.6400031980115;582.2256398989334;582.8484594005589;7241.493095483265;7316.378107860785;7967.8406431871035;7968.402369822286;8070.354371650254;463.5480406603535;483.511653230233;508.84480233529126;546.3853165189162;546.9097598896217;3620.6741393274733;3662.468942003448;3710;3738.5700644425697;3855.325318069327;48747.512524875005;51305.48694513007;51764.22353664698;51785.22322165171;51814.48185518172;44015.55984440179;44085;44147.77926110349;44277;44696.55303446989;39322.2135557293;39781;40240.59759402427;40953.180936381104;41267;7308.926910730825;7344;7375.889361659472;7414.66634001482;7488.363489103487;24482.51034979326;25201;25246.368840779127;25845.483090338465;28709.569356460088;33701.49447758334;34407.655923441445;35040.64959350374;35750.28499429945;35758.8212058938;9857.16214121779;9898.307118501923;9909.851352229867;9942.204623630238;9963.551640176065;10667.359958402521;10712.678619641112;10882.510287036945;10980.176486763365;11131.220814542905;9402.200812930978;9637.614495420385;9655.275854311096;9750.804983900423;10049.598016079275;9544.475053872104;9825.606975720892;9978.700638980843;10188.745281367728;10476.423796691255;10952.507137179005;10966.17753668494;10977;11054.834177487182;11207.047400971009;9285.86071208946;9301.441913485212;9379.390339627902;9531.952340238531;9826.312158148861;8575.3997220194;9082.727518174466;9227.492487912961;9263.120003599648;9479.668211612561 06:27:55 INFO - PROCESS | 23392 | __end_tp_report 06:27:55 INFO - PROCESS | 23392 | __start_cc_report 06:27:55 INFO - PROCESS | 23392 | _x_x_mozilla_cycle_collect,380 06:27:55 INFO - PROCESS | 23392 | __end_cc_report 06:27:55 INFO - PROCESS | 23392 | __startTimestamp1461331675762__endTimestamp 06:27:55 INFO - PROCESS | 23392 | 06:27:55 INFO - PROCESS | 23392 | ------- Summary: start ------- 06:27:55 INFO - PROCESS | 23392 | Number of tests: 6 06:27:55 INFO - PROCESS | 23392 | 06:27:55 INFO - PROCESS | 23392 | [#0] dojo.html Cycles:165 Average:4675.15 Median:4805.26 stddev:475.49 (9.9%) stddev-sans-first:448.30 06:27:55 INFO - PROCESS | 23392 | Values: 2602.9 2660.7 2697.7 2705.7 2720.1 4682.5 4719.5 4742.8 4743.6 4793.5 4618.6 4706.4 4710.2 4792.1 4814.7 4311.4 4320.6 4364.1 4375.8 4405.7 4332.5 4431.4 4454.8 4455.0 4475.1 4211.7 4333.8 4367.9 4397.4 4440.0 4337.8 4347.8 4360.6 4389.6 4400.8 4334.0 4353.0 4362.9 4367.7 4408.0 4612.1 4631.3 4672.7 4682.6 4695.1 5019.7 5025.2 5038.5 5041.8 5110.3 4867.3 5065.4 5090.0 5110.9 5144.1 4729.1 4747.1 4754.6 4805.3 4810.9 5129.5 5169.6 5170.2 5183.1 5223.6 4803.8 4966.8 4971.7 4977.3 5012.4 5009.4 5035.2 5049.8 5073.0 5084.3 4849.6 4938.4 4941.9 4945.6 4967.1 4941.0 4993.5 4996.4 5050.1 5055.8 4163.6 4254.7 4264.5 4264.6 4334.1 3762.2 3763.6 3765.0 3800.3 3804.8 4397.2 4406.9 4409.9 4416.3 4419.2 4844.0 4938.7 5095.2 5150.4 5173.4 4382.1 4384.4 4415.3 4421.6 4450.0 4565.0 4566.8 4571.5 4572.1 4644.4 4659.7 4804.7 4809.4 4819.3 4864.9 5062.8 5092.7 5120.3 5132.3 5153.7 4796.7 4827.5 4829.9 4844.3 4869.1 4822.8 4988.1 5066.0 5094.9 5096.1 4967.3 4985.3 4985.5 4992.2 5066.8 4859.0 4863.2 4868.4 4876.4 4923.4 4770.5 4890.8 4932.5 4940.4 4955.9 4720.2 4757.9 4782.5 4800.4 4834.2 4790.5 4915.0 4920.8 4928.1 4967.5 4856.7 4930.4 4942.2 4984.6 4989.9 06:27:55 INFO - PROCESS | 23392 | 06:27:55 INFO - PROCESS | 23392 | [#1] ext.html Cycles:180 Average:42710.73 Median:33466.75 stddev:77629.51 (232.0%) stddev-sans-first:77782.81 06:27:55 INFO - PROCESS | 23392 | Values: 573.9 599.8 613.1 622.3 643.2 32079.3 32859.2 33123.8 33135.5 33145.0 33544.7 34157.5 34390.3 34427.8 34464.3 7482.6 7638.7 7644.4 7650.6 7661.4 7479.1 7683.5 7710.8 7717.1 7726.8 7681.8 7704.2 7749.9 7756.4 7759.5 7656.4 7696.7 7697.9 7717.0 7726.6 7610.7 7699.9 7745.7 7750.9 7783.1 31109.7 35076.0 35260.5 35284.0 35547.3 2881.3 2937.4 2966.6 3184.2 3482.8 23840.6 23950.4 24340.3 24342.5 24718.3 3120.2 3122.2 3199.2 3210.2 3221.0 165561.0 167289.0 167719.0 169082.0 169241.3 32290.8 32503.5 32522.0 32626.5 32633.5 33260.7 33388.8 58694.4 59805.1 60747.7 11996.2 12021.9 12038.9 12159.3 12167.3 10356.9 10588.7 10617.5 10617.8 10652.6 18371.2 18458.0 18626.0 18670.6 18755.8 6918.6 6969.4 6990.8 7034.2 7215.4 849.7 868.9 976.9 978.1 1065.1 27624.0 27755.7 28309.0 28536.7 28694.6 957.6 979.0 1032.8 1098.9 1103.4 14856.6 15220.5 15384.7 15495.5 15520.8 351313.0 361038.0 361250.0 362269.0 364248.0 49235.5 49542.3 49875.3 49877.0 50102.0 1233.1 1248.0 1269.3 1270.1 1280.6 26269.0 27571.6 27756.2 27909.9 27924.7 42371.4 42528.4 42595.6 42735.1 42932.4 316539.0 316871.0 319387.0 319713.0 321295.0 25817.1 26230.0 26350.3 26387.6 39174.2 36708.0 37721.4 37854.6 37927.6 38395.8 34266.7 34509.5 34676.7 34884.7 34894.0 33775.8 34198.0 34218.7 34308.8 34696.7 31395.4 34629.0 35059.0 35095.0 36876.3 28429.9 29466.0 29470.4 29583.6 30037.5 22613.4 23520.2 24383.8 24728.5 24990.4 06:27:55 INFO - PROCESS | 23392 | 06:27:55 INFO - PROCESS | 23392 | [#2] jquery.html Cycles:180 Average:23107.80 Median:24980.34 stddev:63156.40 (252.8%) stddev-sans-first:63310.51 06:27:55 INFO - PROCESS | 23392 | Values: 379.0 382.6 385.3 385.9 386.4 15360.2 15949.4 16664.0 16775.8 16833.0 9849.4 10555.6 10584.8 10601.8 10613.6 4650.9 4825.1 4860.5 5161.5 5303.9 5259.7 5290.3 5292.7 5293.0 5306.4 4671.5 4860.3 5196.5 5201.1 5252.8 4783.2 4822.7 4836.9 4839.0 4851.1 4479.7 4650.3 4700.6 4724.4 4730.2 12273.2 12278.9 12331.8 12448.8 12468.8 1843.7 1933.7 1937.7 1980.2 2026.9 9023.3 9057.5 9218.7 9398.8 9490.3 1517.8 1753.2 1763.5 1815.7 1831.7 63368.7 67258.3 67590.0 69243.3 70539.6 9597.0 9915.5 9954.7 10023.4 10118.8 13928.1 13961.6 14031.6 14039.9 14054.1 6814.3 6894.1 7137.2 7215.8 7239.3 6606.5 6633.0 6653.3 6656.3 6724.2 4278.8 4336.8 4347.7 4362.1 4441.8 1821.6 1825.9 1838.7 1851.8 1855.3 879.6 886.0 893.1 893.2 908.3 15413.8 15696.8 16048.0 16212.5 16337.9 893.8 918.8 930.7 943.0 952.1 8949.5 9074.5 9141.8 9160.8 9318.0 370082.0 375531.0 385211.0 389125.0 394132.0 69072.7 70105.3 73935.6 74130.6 75849.2 986.0 991.8 1018.7 1064.0 1081.4 14623.5 14663.9 14669.9 14811.3 14876.7 31200.2 31229.5 31693.8 33321.7 34171.5 45481.0 46178.3 46213.5 46353.8 46445.3 7477.6 7720.6 7737.9 7858.5 7866.7 10813.6 11351.5 11656.5 11669.5 11773.8 9929.9 10049.6 10395.6 10410.0 10436.2 9970.7 10049.7 10141.7 10281.8 10407.6 10047.7 10159.7 10217.8 10226.8 10530.9 6769.6 7109.0 7271.6 7275.6 7770.1 7763.8 9786.7 10110.2 10149.6 10409.4 06:27:55 INFO - PROCESS | 23392 | 06:27:55 INFO - PROCESS | 23392 | [#3] mootools.html Cycles:180 Average:5217.20 Median:5380.49 stddev:2876.29 (53.5%) stddev-sans-first:2870.51 06:27:55 INFO - PROCESS | 23392 | Values: 1462.2 1487.5 1637.3 1780.7 1802.1 7044.8 7692.7 7783.0 7893.1 7932.4 7831.1 7835.1 7841.1 7890.8 7940.9 2266.2 2286.7 2290.8 2294.9 2305.4 2249.5 2255.6 2276.1 2278.7 2284.7 2232.2 2250.3 2251.1 2263.7 2265.7 2203.4 2207.7 2207.9 2208.8 2219.4 2218.3 2228.8 2229.1 2234.5 2236.8 7975.5 8036.6 8040.5 8068.2 8075.6 4640.3 4763.8 4809.3 4811.3 4814.2 2844.2 2914.6 2944.5 2963.4 2981.3 859.3 861.8 866.2 868.3 892.7 10340.2 10642.7 10662.0 10735.5 10785.8 4128.2 4191.9 4229.1 4298.2 4310.8 8572.4 8589.1 8599.3 8603.0 8615.3 4598.4 4604.2 4604.7 4612.8 4637.6 3799.4 4271.6 4274.7 4283.9 4393.3 3479.9 3564.9 3622.9 3632.3 3640.1 1107.0 1113.0 1119.2 1119.3 1122.7 728.7 740.2 826.7 857.7 859.6 5359.9 5363.2 5368.7 5392.3 5406.9 960.3 975.3 1003.6 1010.0 1010.7 3555.2 3568.3 3583.3 3611.6 3619.3 9336.0 9404.5 9596.8 9598.3 9713.4 9538.4 9629.8 9670.9 9792.7 9824.8 7381.7 7492.2 7552.5 7554.1 7631.2 5573.7 5575.6 5674.4 5859.2 5898.4 8666.6 8997.8 9026.0 9109.1 9118.7 8859.8 9000.4 9094.9 9237.1 9239.5 6219.0 6618.4 6904.1 6949.2 7087.1 7573.2 7596.4 7636.0 7642.2 7655.3 6802.0 7097.6 7107.8 7183.7 7214.4 7033.2 7074.6 7077.3 7135.1 7157.7 6418.3 6525.7 6651.7 6664.5 6665.1 4711.8 4722.5 4727.0 4736.0 4790.8 4609.9 4625.5 4638.5 4650.1 4705.7 06:27:55 INFO - PROCESS | 23392 | 06:27:55 INFO - PROCESS | 23392 | [#4] prototype.html Cycles:180 Average:4560.89 Median:5245.57 stddev:1322.11 (25.2%) stddev-sans-first:1286.84 06:27:55 INFO - PROCESS | 23392 | Values: 315.2 317.0 320.7 322.3 324.8 5245.2 5245.9 5250.2 5252.4 5256.6 5184.8 5198.4 5217.9 5224.7 5243.0 3853.5 3963.4 4101.1 4113.1 4114.8 4097.8 4098.4 4101.1 4102.0 4137.7 4098.6 4107.9 4120.3 4129.3 4138.0 4025.8 4027.5 4091.1 4102.1 4122.9 3605.0 3612.0 3629.4 3640.9 3656.7 4999.1 5007.7 5033.1 5042.1 5044.2 4603.4 4675.1 4696.2 4734.7 4737.2 5469.7 5476.9 5480.9 5507.9 5513.2 3939.4 3952.5 3966.7 3973.2 3977.1 5544.6 5736.5 5769.1 5790.7 5796.4 4020.5 4044.6 4050.8 4064.6 4065.2 4101.1 4110.8 4111.5 4129.7 4138.8 4694.5 4699.9 4702.7 4719.6 4724.5 5280.9 5580.4 5589.3 5594.7 5604.8 1389.4 1404.7 1407.2 1409.4 1415.8 850.7 904.6 938.5 956.1 957.5 4720.2 4732.2 4762.8 4771.5 4782.4 5597.6 5613.1 5614.5 5619.1 5630.5 4670.0 4737.9 4755.2 4756.9 4763.7 3017.2 3022.9 3035.3 3041.4 3045.7 5256.7 5292.7 5294.5 5323.3 5334.6 5626.3 5739.6 5765.7 5769.2 5770.3 5276.7 5286.4 5299.6 5307.8 5311.1 5500.9 5626.2 5634.6 5644.6 5653.8 5453.9 5460.4 5495.1 5512.8 5525.4 5281.4 5289.5 5308.8 5308.8 5317.7 3743.4 3927.8 3935.5 3941.2 3942.7 5687.2 5714.2 5720.4 5723.2 5724.9 5511.8 5529.3 5530.9 5553.6 5574.0 5337.9 5467.7 5521.2 5532.3 5537.6 5413.3 5421.8 5425.7 5439.8 5455.8 5300.3 5369.0 5490.6 5569.5 5569.5 5392.5 5435.5 5436.6 5436.8 5447.7 06:27:55 INFO - PROCESS | 23392 | 06:27:55 INFO - PROCESS | 23392 | [#5] yui.html Cycles:180 Average:12151.42 Median:23190.16 stddev:13704.68 (59.1%) stddev-sans-first:13715.77 06:27:55 INFO - PROCESS | 23392 | Values: 619.8 675.2 696.3 697.2 712.6 11422.3 11515.7 11610.0 11665.7 11672.2 10544.7 11562.6 11590.8 11756.5 11762.5 630.7 793.9 800.4 804.5 805.3 774.6 804.2 805.6 809.4 810.2 808.7 840.1 848.0 848.7 851.8 799.3 822.2 835.1 835.5 836.6 588.8 595.7 616.6 618.1 618.3 11754.4 11806.9 11814.2 11820.9 11841.1 11724.9 11847.0 11955.3 12148.6 12166.6 11221.4 11261.3 11274.5 11435.0 11473.5 3948.0 3966.9 4014.8 4105.0 4114.8 43252.1 43297.0 43436.8 45472.5 45916.8 9545.5 9754.6 10028.8 10046.5 10066.1 17408.9 17422.9 17520.9 17523.5 17629.1 5813.9 6006.8 6078.3 6260.3 6315.6 3232.5 3288.1 3345.1 3359.5 3412.7 2617.3 2688.6 2707.9 2708.7 2714.2 486.1 509.9 519.9 520.3 533.7 551.6 571.2 580.6 582.2 582.8 7241.5 7316.4 7967.8 7968.4 8070.4 463.5 483.5 508.8 546.4 546.9 3620.7 3662.5 3710.0 3738.6 3855.3 48747.5 51305.5 51764.2 51785.2 51814.5 44015.6 44085.0 44147.8 44277.0 44696.6 39322.2 39781.0 40240.6 40953.2 41267.0 7308.9 7344.0 7375.9 7414.7 7488.4 24482.5 25201.0 25246.4 25845.5 28709.6 33701.5 34407.7 35040.6 35750.3 35758.8 9857.2 9898.3 9909.9 9942.2 9963.6 10667.4 10712.7 10882.5 10980.2 11131.2 9402.2 9637.6 9655.3 9750.8 10049.6 9544.5 9825.6 9978.7 10188.7 10476.4 10952.5 10966.2 10977.0 11054.8 11207.0 9285.9 9301.4 9379.4 9532.0 9826.3 8575.4 9082.7 9227.5 9263.1 9479.7 06:27:55 INFO - PROCESS | 23392 | -------- Summary: end -------- 06:27:55 INFO - PROCESS | 23392 | 06:27:56 INFO - TEST-INFO | 23392: exit 0 06:27:56 INFO - TEST-OK | dromaeo_css | took 1115034ms 06:27:56 INFO - TEST-START | kraken 06:27:56 INFO - operating with platform_type : linux_ 06:27:56 INFO - Initialising browser for kraken test... 06:27:56 INFO - TEST-INFO | started process 23627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplayB3G/profile http://localhost:58721/getInfo.html) 06:28:00 INFO - PROCESS | 23627 | 06:28:00 INFO - PROCESS | 23627 | (process:23693): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:28:01 INFO - PROCESS | 23627 | __metrics Screen width/height:1600/1200 06:28:01 INFO - PROCESS | 23627 | colorDepth:24 06:28:01 INFO - PROCESS | 23627 | Browser inner width/height: 1024/697 06:28:01 INFO - PROCESS | 23627 | __metrics 06:28:01 ERROR - PROCESS | 23627 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:28:02 INFO - TEST-INFO | 23627: exit 0 06:28:02 INFO - Browser initialized. 06:28:02 INFO - Running cycle 1/1 for kraken test... 06:28:02 INFO - TEST-INFO | started process 23744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplayB3G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:28:04 INFO - PROCESS | 23744 | 06:28:04 INFO - PROCESS | 23744 | (process:23804): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:28:14 INFO - PROCESS | 23744 | RSS: Main: 165081088 06:28:14 INFO - PROCESS | 23744 | 06:28:17 INFO - PROCESS | 23744 | Cycle 1(1): loaded http://localhost:58721/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58721/tests/kraken/driver.html?testName=audio-beat-detection) 06:28:18 INFO - PROCESS | 23744 | RSS: Main: 169316352 06:28:18 INFO - PROCESS | 23744 | 06:28:21 INFO - PROCESS | 23744 | Cycle 1(1): loaded http://localhost:58721/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58721/tests/kraken/driver.html?testName=audio-dft) 06:28:21 INFO - PROCESS | 23744 | RSS: Main: 172519424 06:28:21 INFO - PROCESS | 23744 | 06:28:24 INFO - PROCESS | 23744 | Cycle 1(1): loaded http://localhost:58721/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58721/tests/kraken/driver.html?testName=audio-fft) 06:28:25 INFO - PROCESS | 23744 | RSS: Main: 164216832 06:28:25 INFO - PROCESS | 23744 | 06:28:27 INFO - PROCESS | 23744 | Cycle 1(1): loaded http://localhost:58721/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58721/tests/kraken/driver.html?testName=audio-oscillator) 06:28:27 INFO - PROCESS | 23744 | RSS: Main: 164823040 06:28:27 INFO - PROCESS | 23744 | 06:28:30 INFO - PROCESS | 23744 | Cycle 1(1): loaded http://localhost:58721/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58721/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:28:30 INFO - PROCESS | 23744 | RSS: Main: 164405248 06:28:30 INFO - PROCESS | 23744 | 06:28:34 INFO - PROCESS | 23744 | Cycle 1(1): loaded http://localhost:58721/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58721/tests/kraken/driver.html?testName=imaging-darkroom) 06:28:34 INFO - PROCESS | 23744 | RSS: Main: 164454400 06:28:34 INFO - PROCESS | 23744 | 06:28:38 INFO - PROCESS | 23744 | Cycle 1(1): loaded http://localhost:58721/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58721/tests/kraken/driver.html?testName=imaging-desaturate) 06:28:38 INFO - PROCESS | 23744 | RSS: Main: 164372480 06:28:38 INFO - PROCESS | 23744 | 06:28:41 INFO - PROCESS | 23744 | Cycle 1(1): loaded http://localhost:58721/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58721/tests/kraken/driver.html?testName=json-parse-financial) 06:28:42 INFO - PROCESS | 23744 | RSS: Main: 165183488 06:28:42 INFO - PROCESS | 23744 | 06:28:44 INFO - PROCESS | 23744 | Cycle 1(1): loaded http://localhost:58721/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58721/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:28:44 INFO - PROCESS | 23744 | RSS: Main: 165507072 06:28:44 INFO - PROCESS | 23744 | 06:28:46 INFO - PROCESS | 23744 | Cycle 1(1): loaded http://localhost:58721/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58721/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:28:47 INFO - PROCESS | 23744 | RSS: Main: 165584896 06:28:47 INFO - PROCESS | 23744 | 06:28:49 INFO - PROCESS | 23744 | Cycle 1(1): loaded http://localhost:58721/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58721/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:28:50 INFO - PROCESS | 23744 | RSS: Main: 165883904 06:28:50 INFO - PROCESS | 23744 | 06:28:53 INFO - PROCESS | 23744 | Cycle 1(1): loaded http://localhost:58721/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58721/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:28:53 INFO - PROCESS | 23744 | RSS: Main: 165916672 06:28:53 INFO - PROCESS | 23744 | 06:28:56 INFO - PROCESS | 23744 | Cycle 1(1): loaded http://localhost:58721/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58721/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:28:57 INFO - PROCESS | 23744 | RSS: Main: 165814272 06:28:57 INFO - PROCESS | 23744 | 06:28:59 INFO - PROCESS | 23744 | Cycle 1(1): loaded http://localhost:58721/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58721/tests/kraken/driver.html?testName=ai-astar) 06:28:59 INFO - PROCESS | 23744 | RSS: Main: 167133184 06:28:59 INFO - PROCESS | 23744 | 06:28:59 INFO - PROCESS | 23744 | __start_tp_report 06:28:59 INFO - PROCESS | 23744 | _x_x_mozilla_page_load 06:28:59 INFO - PROCESS | 23744 | _x_x_mozilla_page_load_details 06:28:59 INFO - PROCESS | 23744 | |i|pagename|runs| 06:28:59 INFO - PROCESS | 23744 | |0;ai-astar;114;108;112;114;115;125;117;114;113;114 06:28:59 INFO - PROCESS | 23744 | |1;audio-beat-detection;164;135;162;181;146;158;159;134;187;134 06:28:59 INFO - PROCESS | 23744 | |2;audio-dft;164;161;162;164;175;162;161;164;166;163 06:28:59 INFO - PROCESS | 23744 | |3;audio-fft;74;73;78;147;78;78;78;77;156;77 06:28:59 INFO - PROCESS | 23744 | |4;audio-oscillator;95;95;153;94;94;94;144;95;101;155 06:28:59 INFO - PROCESS | 23744 | |5;imaging-gaussian-blur;118;118;118;117;118;117;117;119;118;118 06:28:59 INFO - PROCESS | 23744 | |6;imaging-darkroom;147;147;146;148;146;147;148;147;146;146 06:28:59 INFO - PROCESS | 23744 | |7;imaging-desaturate;95;96;95;95;95;95;96;96;95;100 06:28:59 INFO - PROCESS | 23744 | |8;json-parse-financial;66;65;65;65;65;66;64;79;64;63 06:28:59 INFO - PROCESS | 23744 | |9;json-stringify-tinderbox;64;65;65;65;64;65;65;65;65;64 06:28:59 INFO - PROCESS | 23744 | |10;stanford-crypto-aes;86;80;82;80;81;80;81;80;90;80 06:28:59 INFO - PROCESS | 23744 | |11;stanford-crypto-ccm;143;134;146;140;138;147;134;147;174;138 06:28:59 INFO - PROCESS | 23744 | |12;stanford-crypto-pbkdf2;176;174;170;167;178;171;175;180;173;173 06:28:59 INFO - PROCESS | 23744 | |13;stanford-crypto-sha256-iterative;74;71;79;78;72;71;70;73;72;71 06:28:59 INFO - PROCESS | 23744 | __end_tp_report 06:28:59 INFO - PROCESS | 23744 | __start_cc_report 06:28:59 INFO - PROCESS | 23744 | _x_x_mozilla_cycle_collect,932 06:28:59 INFO - PROCESS | 23744 | __end_cc_report 06:28:59 INFO - PROCESS | 23744 | __startTimestamp1461331739277__endTimestamp 06:28:59 INFO - PROCESS | 23744 | 06:28:59 INFO - PROCESS | 23744 | ------- Summary: start ------- 06:28:59 INFO - PROCESS | 23744 | Number of tests: 14 06:28:59 INFO - PROCESS | 23744 | 06:28:59 INFO - PROCESS | 23744 | [#0] ai-astar Cycles:10 Average:114.60 Median:114.00 stddev:4.33 (3.8%) stddev-sans-first:4.58 06:28:59 INFO - PROCESS | 23744 | Values: 114.0 108.0 112.0 114.0 115.0 125.0 117.0 114.0 113.0 114.0 06:28:59 INFO - PROCESS | 23744 | 06:28:59 INFO - PROCESS | 23744 | [#1] audio-beat-detection Cycles:10 Average:156.00 Median:160.50 stddev:18.88 (11.8%) stddev-sans-first:19.80 06:28:59 INFO - PROCESS | 23744 | Values: 164.0 135.0 162.0 181.0 146.0 158.0 159.0 134.0 187.0 134.0 06:28:59 INFO - PROCESS | 23744 | 06:28:59 INFO - PROCESS | 23744 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:4.10 (2.5%) stddev-sans-first:4.35 06:28:59 INFO - PROCESS | 23744 | Values: 164.0 161.0 162.0 164.0 175.0 162.0 161.0 164.0 166.0 163.0 06:28:59 INFO - PROCESS | 23744 | 06:28:59 INFO - PROCESS | 23744 | [#3] audio-fft Cycles:10 Average:91.60 Median:77.50 stddev:31.69 (40.9%) stddev-sans-first:32.97 06:28:59 INFO - PROCESS | 23744 | Values: 74.0 73.0 78.0 147.0 78.0 78.0 78.0 77.0 156.0 77.0 06:28:59 INFO - PROCESS | 23744 | 06:28:59 INFO - PROCESS | 23744 | [#4] audio-oscillator Cycles:10 Average:112.00 Median:94.00 stddev:26.90 (28.6%) stddev-sans-first:27.82 06:28:59 INFO - PROCESS | 23744 | Values: 95.0 95.0 153.0 94.0 94.0 94.0 144.0 95.0 101.0 155.0 06:28:59 INFO - PROCESS | 23744 | 06:28:59 INFO - PROCESS | 23744 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 06:28:59 INFO - PROCESS | 23744 | Values: 118.0 118.0 118.0 117.0 118.0 117.0 117.0 119.0 118.0 118.0 06:28:59 INFO - PROCESS | 23744 | 06:28:59 INFO - PROCESS | 23744 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 06:28:59 INFO - PROCESS | 23744 | Values: 147.0 147.0 146.0 148.0 146.0 147.0 148.0 147.0 146.0 146.0 06:28:59 INFO - PROCESS | 23744 | 06:28:59 INFO - PROCESS | 23744 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:1.55 (1.6%) stddev-sans-first:1.62 06:28:59 INFO - PROCESS | 23744 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 100.0 06:28:59 INFO - PROCESS | 23744 | 06:28:59 INFO - PROCESS | 23744 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:65.00 stddev:4.59 (7.1%) stddev-sans-first:4.87 06:28:59 INFO - PROCESS | 23744 | Values: 66.0 65.0 65.0 65.0 65.0 66.0 64.0 79.0 64.0 63.0 06:28:59 INFO - PROCESS | 23744 | 06:28:59 INFO - PROCESS | 23744 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 06:28:59 INFO - PROCESS | 23744 | Values: 64.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 65.0 64.0 06:28:59 INFO - PROCESS | 23744 | 06:28:59 INFO - PROCESS | 23744 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.00 stddev:3.37 (4.2%) stddev-sans-first:3.24 06:28:59 INFO - PROCESS | 23744 | Values: 86.0 80.0 82.0 80.0 81.0 80.0 81.0 80.0 90.0 80.0 06:28:59 INFO - PROCESS | 23744 | 06:28:59 INFO - PROCESS | 23744 | [#11] stanford-crypto-ccm Cycles:10 Average:144.10 Median:144.50 stddev:11.60 (8.0%) stddev-sans-first:12.30 06:28:59 INFO - PROCESS | 23744 | Values: 143.0 134.0 146.0 140.0 138.0 147.0 134.0 147.0 174.0 138.0 06:28:59 INFO - PROCESS | 23744 | 06:28:59 INFO - PROCESS | 23744 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:174.50 stddev:3.83 (2.2%) stddev-sans-first:3.97 06:28:59 INFO - PROCESS | 23744 | Values: 176.0 174.0 170.0 167.0 178.0 171.0 175.0 180.0 173.0 173.0 06:28:59 INFO - PROCESS | 23744 | 06:28:59 INFO - PROCESS | 23744 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:72.50 stddev:3.07 (4.2%) stddev-sans-first:3.24 06:28:59 INFO - PROCESS | 23744 | Values: 74.0 71.0 79.0 78.0 72.0 71.0 70.0 73.0 72.0 71.0 06:28:59 INFO - PROCESS | 23744 | -------- Summary: end -------- 06:28:59 INFO - PROCESS | 23744 | 06:29:00 INFO - TEST-INFO | 23744: exit 0 06:29:00 INFO - TEST-OK | kraken | took 63706ms 06:29:00 INFO - SUITE-END | took 1178s 06:29:00 INFO - Completed test suite (00:19:38) 06:29:00 INFO - javascript benchmark 06:29:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.8568428736417, 2660.747229013243, 2697.7032526422095, 2705.7429544193296, 2720.1023662191465, 4682.46151692555, 4719.480857105716, 4742.834000809972, 4743.573078422941, 4793.520647935209, 4618.630509559235, 4706.435227772664, 4710.2228132358205, 4792.089502994429, 4814.7351895645725, 4311.396404503372, 4320.567943205678, 4364.127174565084, 4375.7529104205305, 4405.691601587891, 4332.458442694663, 4431.401760762305, 4454.799534020977, 4455.019895622958, 4475.082608065355, 4211.7472951623, 4333.761643109628, 4367.9344809828035, 4397.384366188736, 4440.02319489715, 4337.783110844445, 4347.782610869475, 4360.6293465055505, 4389.648828093745, 4400.823967041314, 4333.978330108361, 4352.977050393155, 4362.934555981663, 4367.650587952956, 4407.977960110179, 4612.100640375128, 4631.258998560214, 4672.672912896099, 4682.6253899687945, 4695.084458530588, 5019.67372120811, 5025.221090730943, 5038.470960549126, 5041.823536176216, 5110.310108135392, 4867.342908707315, 5065.392152941634, 5090.0, 5110.948890511085, 5144.099782538041, 4729.148753224418, 4747.145513807548, 4754.643401744883, 4805.255185446262, 4810.8797280068275, 5129.461406552333, 5169.638125331191, 5170.1727723564045, 5183.0670479314085, 5223.634345595848, 4803.807847686124, 4966.826161084345, 4971.676841005323, 4977.303177555145, 5012.423571289349, 5009.398872135367, 5035.169197082514, 5049.82325618609, 5072.9746351268, 5084.339035925306, 4849.587785038311, 4938.358013458227, 4941.901161976741, 4945.604351651859, 4967.105920934194, 4941.0, 4993.475685053089, 4996.350474438373, 5050.116229659795, 5055.823046193365, 4163.5836416358125, 4254.744715317091, 4264.509581398117, 4264.552222016706, 4334.068175342317, 3762.172322089136, 3763.5671897732113, 3765.0399148217575, 3800.315943130263, 3804.8287827047848, 4397.164538737629, 4406.911861762746, 4409.889752756143, 4416.337549367557, 4419.248727716296, 4844.0, 4938.703677779345, 5095.210242412358, 5150.356205474316, 5173.405058418255, 4382.145481631052, 4384.386185933972, 4415.337699345124, 4421.5578442156175, 4449.9555004450185, 4565.041341318294, 4566.794494247767, 4571.474280457724, 4572.1312950539295, 4644.396228490342, 4659.697119687209, 4804.687695299935, 4809.44691360498, 4819.325294458778, 4864.902701946012, 5062.848114556569, 5092.694438333712, 5120.283160357479, 5132.30713853625, 5153.6907785532985, 4796.712197268175, 4827.493113223201, 4829.879253018703, 4844.273358996179, 4869.074875773592, 4822.807087716452, 4988.077205716954, 5066.0, 5094.853657926937, 5096.0827051131155, 4967.25491176312, 4985.252212168204, 4985.52637499437, 4992.201247800334, 5066.771995260296, 4858.975705121452, 4863.221884498464, 4868.440129385166, 4876.4392094909535, 4923.409190896972, 4770.475247722818, 4890.828820991248, 4932.506749325039, 4940.407151141886, 4955.925661115159, 4720.221163507983, 4757.857264282077, 4782.52174782519, 4800.35195248651, 4834.154023046023, 4790.5448982346625, 4915.0, 4920.827771027997, 4928.088303663833, 4967.503249675148, 4856.732879691651, 4930.408350997904, 4942.1598328285, 4984.6261530384645, 4989.900201996013], "value": 4645.778828802644, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.8938296415164, 599.7990673124503, 613.0926229180815, 622.2999125983271, 643.2088531106741, 32079.310879248893, 32859.178520536996, 33123.83438082809, 33135.502967455475, 33145.0, 33544.66455335446, 34157.48763768545, 34390.312193756174, 34427.82786086066, 34464.31071378571, 7482.6258687065565, 7638.694452221905, 7644.388448924073, 7650.579218143, 7661.425393095512, 7479.102507699084, 7683.462157648967, 7710.7686769397005, 7717.112532058801, 7726.8454630907345, 7681.807954801119, 7704.229577042279, 7749.883751743729, 7756.3794896408435, 7759.495632783851, 7656.425768067389, 7696.653650585709, 7697.884531732028, 7716.9614151929445, 7726.575038372887, 7610.65752041154, 7699.923000769976, 7745.728899488491, 7750.883736743954, 7783.143854176036, 31109.68890311113, 35076.0, 35260.47109293363, 35284.0, 35547.28905421903, 2881.2652773542823, 2937.3537821679197, 2966.569847372119, 3184.2357834119875, 3482.8432720527635, 23840.642390363984, 23950.401239969142, 24340.26979190627, 24342.513149737082, 24718.25845224646, 3120.1731541141617, 3122.2350524121507, 3199.152224660467, 3210.181403742031, 3221.0014895382506, 165561.0, 167289.0, 167719.0, 169082.0, 169241.3075869238, 32290.83854580712, 32503.51244731331, 32522.0, 32626.510602340983, 32633.51049734256, 33260.667393325755, 33388.83305583456, 58694.41305586975, 59805.10292345619, 60747.69626151841, 11996.220245684002, 12021.939890300668, 12038.87961120395, 12159.331236781885, 12167.330796806084, 10356.896431035744, 10588.682339529827, 10617.469126543796, 10617.84073238902, 10652.62715804943, 18371.173297201658, 18458.0, 18626.0, 18670.626587468174, 18755.812441875405, 6918.5502942308585, 6969.386480069974, 6990.755323563651, 7034.2262351141335, 7215.428362960368, 849.7408290471342, 868.9435186712969, 976.9169620582188, 978.0708327089294, 1065.0521036277719, 27624.0, 27755.722442775717, 28309.0, 28536.714632853407, 28694.569581456293, 957.5643082397493, 979.0, 1032.7779527401644, 1098.8681358236902, 1103.4041617526607, 14856.62858428548, 15220.467283645019, 15384.692306153815, 15495.45765898188, 15520.767188492182, 351313.0, 361038.0, 361250.0, 362269.0, 364248.0, 49235.50764492381, 49542.256866147036, 49875.25187122196, 49877.0, 50101.99796004059, 1233.0875152387168, 1247.9563215287603, 1269.2955409747494, 1270.0855384123417, 1280.6158152554383, 26269.0, 27571.586426204023, 27756.167314980583, 27909.860450697615, 27924.72075279221, 42371.364429534195, 42528.362074568286, 42595.5740442604, 42735.14529709326, 42932.35601465918, 316539.0, 316871.0, 319387.0, 319713.0, 321295.0, 25817.09640162585, 26230.0, 26350.341241469116, 26387.60418593684, 39174.21651566896, 36708.0, 37721.434178486794, 37854.62145378511, 37927.62072379241, 38395.80802095972, 34266.657333426345, 34509.48235776415, 34676.65323346734, 34884.651153489154, 34894.0, 33775.83112084424, 34198.0, 34218.657813421545, 34308.82845585756, 34696.653033469345, 31395.37209255848, 34629.0, 35059.0, 35095.0, 36876.26247475089, 28429.857850710614, 29466.0, 29470.410591787615, 29583.556246656746, 30037.54943675803, 22613.43466413353, 23520.176793812134, 24383.75616243815, 24728.505429891662, 24990.37524061913], "value": 16553.992122016425, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.9658930696237, 382.5887171290863, 385.25260993672276, 385.89387918322456, 386.37600275554985, 15360.231988400577, 15949.441769538054, 16664.0, 16775.83224167758, 16832.990020598758, 9849.409035457878, 10555.577776888915, 10584.78830423393, 10601.840972385402, 10613.57545698173, 4650.883727906812, 4825.107355139293, 4860.513948605147, 5161.509656582619, 5303.893922121555, 5259.658122222062, 5290.312259406272, 5292.708901010443, 5293.04725149473, 5306.416294207634, 4671.509491503394, 4860.270959356108, 5196.454372290912, 5201.143414906234, 5252.789888404459, 4783.210770222909, 4822.710637361734, 4836.854894353175, 4838.951610483903, 4851.102546028996, 4479.686421950465, 4650.325702773079, 4700.576948074689, 4724.362211101526, 4730.219513780222, 12273.20224185434, 12278.877211227862, 12331.753364932742, 12448.75102497954, 12468.81296780549, 1843.7050071988551, 1933.680942644462, 1937.7480927479337, 1980.1683293016968, 2026.8581199316054, 9023.278137748965, 9057.456552606798, 9218.677346292914, 9398.812023759487, 9490.288228382899, 1517.8254500732446, 1753.2373417563401, 1763.4885883093887, 1815.682255605264, 1831.6829211048034, 63368.683156583924, 67258.32741672569, 67590.0, 69243.30756692469, 70539.64730176418, 9597.0, 9915.454649994319, 9954.701358959242, 10023.448710321003, 10118.848217276747, 13928.094673846168, 13961.581152565439, 14031.579052628438, 14039.929800350932, 14054.086484378482, 6814.318568143146, 6894.13823272091, 7137.2149063602965, 7215.819604509929, 7239.348458638748, 6606.504512161511, 6633.038209459602, 6653.2681405045405, 6656.30108838565, 6724.226713927863, 4278.828846846153, 4336.82652693895, 4347.739135651807, 4362.0839623679385, 4441.822327106945, 1821.5992481654016, 1825.8813177143443, 1838.7405669036536, 1851.7963024067342, 1855.3413538194018, 879.5558243087328, 885.9822803543893, 893.1425831201989, 893.2050475077186, 908.2643059122132, 15413.768793468107, 15696.843031569766, 16048.03711777297, 16212.513624591282, 16337.918310408371, 893.8346405914926, 918.7611221082433, 930.7068273493828, 942.9764255893657, 952.1335584617964, 8949.478588639817, 9074.546272686472, 9141.77145571366, 9160.770980725536, 9317.953410232905, 370082.0, 375531.0, 385211.0, 389125.0, 394132.0, 69072.6546367265, 70105.2989470109, 73935.63032184912, 74130.629346854, 75849.24150758421, 985.9950700246596, 991.7570195302197, 1018.6943916825071, 1063.9734006649896, 1081.389015206406, 14623.488177913721, 14663.853361466248, 14669.92665036668, 14811.333489993192, 14876.702465950837, 31200.21999450032, 31229.531557027116, 31693.841530792197, 33321.66678333186, 34171.4874276891, 45481.0, 46178.307325390815, 46213.53786462092, 46353.768231158625, 46445.303320449544, 7477.626118693935, 7720.575368354795, 7737.883931741141, 7858.528488290721, 7866.685332586632, 10813.62152324665, 11351.54593816238, 11656.53373865036, 11669.533218671158, 11773.76452470963, 9929.900700992897, 10049.598016079275, 10395.58417663285, 10410.0, 10436.165106791286, 9970.651027214013, 10049.69850904474, 10141.695749127539, 10281.794364112526, 10407.58369665205, 10047.698569042941, 10159.7460063499, 10217.795644086927, 10226.795464090825, 10530.894691053298, 6769.593824370553, 7108.964455177898, 7271.563706177646, 7275.6362181889635, 7770.106437759504, 7763.844723105619, 9786.657466988621, 10110.241731870286, 10149.594016239267, 10409.375437473776], "value": 7803.602409380197, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.188485390608, 1487.5314276003057, 1637.2632315458047, 1780.7417924400954, 1802.0899445779887, 7044.753433629824, 7692.730754423596, 7783.0, 7893.13175550689, 7932.405069619773, 7831.1385747567865, 7835.138134805167, 7841.098273698526, 7890.763277101696, 7940.9205907940905, 2266.1841736974716, 2286.6798648189265, 2290.770922907704, 2294.8623082615013, 2305.4121199094207, 2249.5275992041693, 2255.605269077913, 2276.1009401286483, 2278.737945136314, 2284.737255215655, 2232.174095584636, 2250.3473992542145, 2251.0545570860195, 2263.671767593698, 2265.7394399644004, 2203.449137715571, 2207.724034495688, 2207.8896055197256, 2208.757036725951, 2219.422950033003, 2218.267971569378, 2228.765979572154, 2229.052652622629, 2234.497238121426, 2236.8434209605334, 7975.521468711896, 8036.557989310586, 8040.477368970998, 8068.233517815798, 8075.596220189026, 4640.257558790611, 4763.833265835714, 4809.278608208761, 4811.302361157647, 4814.205656066745, 2844.1894060192953, 2914.635670541182, 2944.455275773989, 2963.4221326841275, 2981.344104297051, 859.2824991132412, 861.8233262181237, 866.1641515937151, 868.274990383031, 892.7009451833643, 10340.224483163793, 10642.680719578348, 10662.0, 10735.516901739362, 10785.83821242682, 4128.174365126986, 4191.91616167675, 4229.111886503869, 4298.20483210607, 4310.7629080400875, 8572.442791218551, 8589.141085891486, 8599.269062129664, 8603.01065377477, 8615.310775137974, 4598.425196850394, 4604.171249175113, 4604.677672562889, 4612.838550650778, 4637.559431853969, 3799.430085487199, 4271.615554600101, 4274.743515389025, 4283.850065247701, 4393.340998850134, 3479.8956031319103, 3564.8752293669595, 3622.945655815165, 3632.2917031178667, 3640.1263696713127, 1106.950187241576, 1112.9888701112886, 1119.1774046076127, 1119.339589642115, 1122.7473818390797, 728.66481418547, 740.193189423531, 826.6775957376628, 857.7341024282492, 859.6002858670748, 5359.866003349947, 5363.19552067193, 5368.7047212403695, 5392.272043274186, 5406.918896216481, 960.3181740963994, 975.317277905469, 1003.5734812704571, 1009.9697009089739, 1010.6664800615779, 3555.1645363339594, 3568.3220188164164, 3583.3191693578137, 3611.638836116367, 3619.3485172668647, 9336.0, 9404.482753448627, 9596.808063838684, 9598.280128990353, 9713.417194968184, 9538.380005299634, 9629.807403852024, 9670.854937175947, 9792.657256996114, 9824.754381140387, 7381.66782494789, 7492.175860655324, 7552.471327007057, 7554.093508778872, 7631.1987241341085, 5573.749181286771, 5575.637583557056, 5674.375818660027, 5859.206367321716, 5898.35118136996, 8666.566671666518, 8997.820043599222, 9025.954870225607, 9109.134632209929, 9118.680846170351, 8859.778505537413, 9000.414973026733, 9094.863577046217, 9237.12247336502, 9239.538023098683, 6219.0, 6618.404343609098, 6904.067950826574, 6949.166100068024, 7087.114110736158, 7573.166951635426, 7596.392288616787, 7635.961820190863, 7642.235776422535, 7655.311022008046, 6801.965990170018, 7097.609631470319, 7107.786766397016, 7183.748568800067, 7214.422846172399, 7033.226345101933, 7074.575525468488, 7077.292270772881, 7135.108111486064, 7157.7136914522835, 6418.293987661447, 6525.673716314071, 6651.733930642914, 6664.533482656361, 6665.0668906352175, 4711.81152753886, 4722.527747225387, 4726.976365118152, 4736.0, 4790.808367665254, 4609.907801844011, 4625.468071171724, 4638.536146385334, 4650.093231819898, 4705.694129881546], "value": 4215.407585273883, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.2166865339631, 316.9745872103744, 320.70174737494136, 322.3343795063193, 324.8473217587734, 5245.186996015615, 5245.947540524594, 5250.238715386276, 5252.395974462938, 5256.605754568403, 5184.766685499152, 5198.428172900978, 5217.921731174036, 5224.7387630618505, 5242.973785131078, 3853.5183102112237, 3963.365861462167, 4101.138760860208, 4113.115680128772, 4114.753114813106, 4097.7541347519245, 4098.426220329156, 4101.0772576170275, 4102.0, 4137.66898648109, 4098.610631989956, 4107.917841643165, 4120.25835349637, 4129.318662420697, 4138.0, 4025.838966441339, 4027.456293400383, 4091.0795071108764, 4102.138550904314, 4122.855700050513, 3604.981975090134, 3611.981940090309, 3629.401148810443, 3640.854365825364, 3656.7257455690665, 4999.12515309823, 5007.69953802773, 5033.144365457881, 5042.092423363793, 5044.167712327461, 4603.378543896564, 4675.111728771522, 4696.178168820477, 4734.739589322586, 4737.218358970766, 5469.726513674301, 5476.863078423071, 5480.945190548123, 5507.862303442406, 5513.228148059275, 3939.4484772131923, 3952.505936757905, 3966.682665386762, 3973.205358928197, 3977.1449138435373, 5544.584156188262, 5736.541076713895, 5769.07694768835, 5790.652560846363, 5796.449337312949, 4020.4974378202724, 4044.6359827615656, 4050.7569545826755, 4064.634182923551, 4065.1869626074904, 4101.097758493127, 4110.815013324408, 4111.465509483748, 4129.731567448106, 4138.8344466221615, 4694.50707675696, 4699.929501057487, 4702.741349225757, 4719.5752382285755, 4724.480307166209, 5280.867978300574, 5580.414056524088, 5589.301337332833, 5594.720263986785, 5604.8038318658655, 1389.4095009620871, 1404.7401230772136, 1407.2049292149902, 1409.4221369238562, 1415.8230221222348, 850.6852464588018, 904.5929331800716, 938.4979036215592, 956.1012648110753, 957.4781743949565, 4720.221163507983, 4732.195526760459, 4762.761861906891, 4771.5467030632035, 4782.402199725035, 5597.636153650081, 5613.101903695389, 5614.466625670637, 5619.100943848965, 5630.493255606933, 4670.0, 4737.905241895142, 4755.167845627071, 4756.857294281177, 4763.69036012658, 3017.2456885778556, 3022.863971121305, 3035.2867076237067, 3041.376517813843, 3045.7411120055044, 5256.710880901511, 5292.735363231823, 5294.470552944675, 5323.281357016831, 5334.626576139711, 5626.2685850839125, 5739.569532285095, 5765.682887441231, 5769.221155144086, 5770.336411312753, 5276.709780962084, 5286.444923283, 5299.602529810357, 5307.840764777063, 5311.070562651521, 5500.862478437911, 5626.24045753818, 5634.577406694432, 5644.6330988485615, 5653.773849045992, 5453.918191227214, 5460.3720572133125, 5495.120780675233, 5512.751926163252, 5525.419830917856, 5281.445448228034, 5289.523942845162, 5308.761105750174, 5308.840734777963, 5317.734113294242, 3743.419769935664, 3927.783971881574, 3935.5277366716177, 3941.2117576485393, 3942.72400931932, 5687.20379146928, 5714.200011998407, 5720.3707592164, 5723.167032318862, 5724.914126288026, 5511.807086751945, 5529.281193444826, 5530.944690553043, 5553.583481238842, 5573.972130139324, 5337.893242135058, 5467.7266136692215, 5521.2270282161335, 5532.336119665666, 5537.640053396516, 5413.323334583177, 5421.756020978986, 5425.674459532441, 5439.782408703608, 5455.781768729206, 5300.31095957523, 5369.0, 5490.5607551395, 5569.496236016334, 5569.526590239713, 5392.487713667196, 5435.483629055233, 5436.565074793928, 5436.836894893159, 5447.727613619382], "value": 4138.176749185999, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.8481372063843, 675.1926284851859, 696.3106524540704, 697.1842943755805, 712.579578048951, 11422.31466112034, 11515.654530364092, 11610.0, 11665.650030499088, 11672.1829471937, 10544.683659490209, 11562.59530916418, 11590.768184636303, 11756.470958806853, 11762.470688819003, 630.7130255733653, 793.8729803231485, 800.371708209056, 804.5293503300547, 805.3396215103588, 774.6281784743327, 804.2480280937314, 805.6414895371562, 809.3727361295014, 810.1857633078747, 808.720991258018, 840.0968958369747, 847.9576021198947, 848.6902280667574, 851.7955690634266, 799.2806474173233, 822.2106777493614, 835.131463278193, 835.51122593283, 836.6109758962051, 588.8204097750184, 595.6783336998016, 616.6300219868089, 618.0636335951037, 618.3074956049209, 11754.353510556915, 11806.940965295204, 11814.17300788945, 11820.940895295469, 11841.052715782716, 11724.882751172465, 11847.0, 11955.282683039046, 12148.635540933787, 12166.57416990401, 11221.438928053565, 11261.324320540794, 11274.492647830786, 11435.0, 11473.541058357656, 3947.960520394788, 3966.8809935701975, 4014.759114453142, 4105.0, 4114.794260287003, 43252.134957300994, 43297.0, 43436.78281608572, 45472.54527454716, 45916.770416148036, 9545.52272386378, 9754.561044753003, 10028.849567256497, 10046.547905344278, 10066.094051535398, 17408.912955435142, 17422.912885435493, 17520.912395438198, 17523.474295771146, 17629.118544072746, 5813.883722325614, 6006.759729610854, 6078.331383547807, 6260.342664020303, 6315.621062736251, 3232.4828027515487, 3288.079337785424, 3345.1469875181674, 3359.5296658467832, 3412.7440441966455, 2617.332580192077, 2688.623592697024, 2707.9323016924736, 2708.7291270873147, 2714.185744276709, 486.1079918349797, 509.8827269727983, 519.8934218485201, 520.3235793468476, 533.7358007786094, 551.5918220516869, 571.1660974976497, 580.6400031980115, 582.2256398989334, 582.8484594005589, 7241.493095483265, 7316.378107860785, 7967.8406431871035, 7968.402369822286, 8070.354371650254, 463.5480406603535, 483.511653230233, 508.84480233529126, 546.3853165189162, 546.9097598896217, 3620.6741393274733, 3662.468942003448, 3710.0, 3738.5700644425697, 3855.325318069327, 48747.512524875005, 51305.48694513007, 51764.22353664698, 51785.22322165171, 51814.48185518172, 44015.55984440179, 44085.0, 44147.77926110349, 44277.0, 44696.55303446989, 39322.2135557293, 39781.0, 40240.59759402427, 40953.180936381104, 41267.0, 7308.926910730825, 7344.0, 7375.889361659472, 7414.66634001482, 7488.363489103487, 24482.51034979326, 25201.0, 25246.368840779127, 25845.483090338465, 28709.569356460088, 33701.49447758334, 34407.655923441445, 35040.64959350374, 35750.28499429945, 35758.8212058938, 9857.16214121779, 9898.307118501923, 9909.851352229867, 9942.204623630238, 9963.551640176065, 10667.359958402521, 10712.678619641112, 10882.510287036945, 10980.176486763365, 11131.220814542905, 9402.200812930978, 9637.614495420385, 9655.275854311096, 9750.804983900423, 10049.598016079275, 9544.475053872104, 9825.606975720892, 9978.700638980843, 10188.745281367728, 10476.423796691255, 10952.507137179005, 10966.17753668494, 10977.0, 11054.834177487182, 11207.047400971009, 9285.86071208946, 9301.441913485212, 9379.390339627902, 9531.952340238531, 9826.312158148861, 8575.3997220194, 9082.727518174466, 9227.492487912961, 9263.120003599648, 9479.668211612561], "value": 5703.183988035819, "unit": "score"}], "name": "dromaeo_css", "value": 6251.883076780826, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 112.0, 114.0, 115.0, 125.0, 117.0, 114.0, 113.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 135.0, 162.0, 181.0, 146.0, 158.0, 159.0, 134.0, 187.0, 134.0], "value": 156.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 162.0, 164.0, 175.0, 162.0, 161.0, 164.0, 166.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 78.0, 147.0, 78.0, 78.0, 78.0, 77.0, 156.0, 77.0], "value": 91.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 153.0, 94.0, 94.0, 94.0, 144.0, 95.0, 101.0, 155.0], "value": 112.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 119.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 148.0, 146.0, 147.0, 148.0, 147.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 100.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 64.0, 79.0, 64.0, 63.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 82.0, 80.0, 81.0, 80.0, 81.0, 80.0, 90.0, 80.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 134.0, 146.0, 140.0, 138.0, 147.0, 134.0, 147.0, 174.0, 138.0], "value": 144.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 174.0, 170.0, 167.0, 178.0, 171.0, 175.0, 180.0, 173.0, 173.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 79.0, 78.0, 72.0, 71.0, 70.0, 73.0, 72.0, 71.0], "value": 73.1, "unit": "score"}], "name": "kraken", "value": 1602.6, "alertThreshold": 2.0}]} 06:29:00 INFO - Return code: 0 06:29:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:29:00 ERROR - # TBPL SUCCESS # 06:29:00 INFO - Running post-action listener: _resource_record_post_action 06:29:00 INFO - Running post-run listener: _resource_record_post_run 06:29:01 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 531226624; Read time: 8; Write time: 523668 06:29:01 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248041472; Read time: 0; Write time: 307292 06:29:01 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283185152; Read time: 8; Write time: 216376 06:29:01 INFO - Running post-run listener: _upload_blobber_files 06:29:01 INFO - Blob upload gear active. 06:29:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:29:01 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 06:29:01 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'] 06:29:01 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 06:29:02 INFO - (blobuploader) - INFO - Open directory for files ... 06:29:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:29:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:29:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:29:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:29:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:29:02 INFO - (blobuploader) - INFO - Done attempting. 06:29:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:29:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:29:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:29:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:29:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:29:03 INFO - (blobuploader) - INFO - Done attempting. 06:29:03 INFO - (blobuploader) - INFO - Iteration through files over. 06:29:03 INFO - Return code: 0 06:29:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:29:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:29:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/77c311e0f9574699470a2c4cbcb4e25a469d42e93e5060bf6a4b530927a0cec9e97d78817b750ef2498b339f0a5d73011186cda313d7de47be8fb3d1785d388e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab90e61ddd184d8382f293fc60d5ac30870d3aa894fd7c23c21d1b95325df3a9ab427c005f32ea214104c07addfc2c82624f8ba3a627ee9c57858127d0094924"} 06:29:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:29:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:29:03 INFO - Contents: 06:29:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/77c311e0f9574699470a2c4cbcb4e25a469d42e93e5060bf6a4b530927a0cec9e97d78817b750ef2498b339f0a5d73011186cda313d7de47be8fb3d1785d388e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab90e61ddd184d8382f293fc60d5ac30870d3aa894fd7c23c21d1b95325df3a9ab427c005f32ea214104c07addfc2c82624f8ba3a627ee9c57858127d0094924"} 06:29:03 INFO - Running post-run listener: copy_logs_to_upload_dir 06:29:03 INFO - Copying logs to upload dir... 06:29:03 INFO - mkdir: /builds/slave/test/build/upload/logs 06:29:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.833923 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-22 06:29:03.352675) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:03.356454) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267 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/77c311e0f9574699470a2c4cbcb4e25a469d42e93e5060bf6a4b530927a0cec9e97d78817b750ef2498b339f0a5d73011186cda313d7de47be8fb3d1785d388e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab90e61ddd184d8382f293fc60d5ac30870d3aa894fd7c23c21d1b95325df3a9ab427c005f32ea214104c07addfc2c82624f8ba3a627ee9c57858127d0094924"} build_url:https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011126 build_url: 'https://queue.taskcluster.net/v1/task/HnBFXzznRKavSHFvza-LlQ/artifacts/public/build/firefox-48.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/77c311e0f9574699470a2c4cbcb4e25a469d42e93e5060bf6a4b530927a0cec9e97d78817b750ef2498b339f0a5d73011186cda313d7de47be8fb3d1785d388e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab90e61ddd184d8382f293fc60d5ac30870d3aa894fd7c23c21d1b95325df3a9ab427c005f32ea214104c07addfc2c82624f8ba3a627ee9c57858127d0094924"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:03.380942) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:03.381248) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1461330507.327904-742391267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:03.465054) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:29:03.465397) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:29:03.465686) ========= ========= Total master_lag: 0.17 =========