builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1461245414.0 results: success (0) buildid: 20160421055405 builduid: 904aef4727814550a5512537981812d9 revision: adc7dd34508b4133a986bee775b6a75552e13ecb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 06:30:14.002047) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 06:30:14.002450) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 06:30:14.003028) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 06:30:14.020734) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 06:30:14.021023) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 06:30:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-04-21 06:30:14 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134845 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 06:30:14.169670) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 06:30:14.170029) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014455 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 06:30:14.220531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 06:30:14.220889) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev adc7dd34508b4133a986bee775b6a75552e13ecb --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 adc7dd34508b4133a986bee775b6a75552e13ecb --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=b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 06:30:14,401 truncating revision to first 12 chars 2016-04-21 06:30:14,401 Setting DEBUG logging. 2016-04-21 06:30:14,401 attempt 1/10 2016-04-21 06:30:14,401 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/adc7dd34508b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 06:30:14,689 unpacking tar archive at: fx-team-adc7dd34508b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.621765 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 06:30:14.855725) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 06:30:14.856220) ========= script_repo_revision: adc7dd34508b4133a986bee775b6a75552e13ecb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 06:30:14.856791) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 06:30:14.857196) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 06:30:14.870854) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-21 06:30:14.871432) ========= /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=b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:30:15 INFO - MultiFileLogger online at 20160421 06:30:15 in /builds/slave/test 06:30:15 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:30:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:30:15 INFO - {'append_to_log': False, 06:30:15 INFO - 'base_work_dir': '/builds/slave/test', 06:30:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:30:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:30:15 INFO - 'branch': 'Fx-Team-Non-PGO', 06:30:15 INFO - 'buildbot_json_path': 'buildprops.json', 06:30:15 INFO - 'config_files': ('talos/linux_config.py',), 06:30:15 INFO - 'default_actions': ('clobber', 06:30:15 INFO - 'read-buildbot-config', 06:30:15 INFO - 'download-and-extract', 06:30:15 INFO - 'populate-webroot', 06:30:15 INFO - 'create-virtualenv', 06:30:15 INFO - 'install', 06:30:15 INFO - 'run-tests'), 06:30:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:30:15 INFO - 'download_minidump_stackwalk': True, 06:30:15 INFO - 'download_symbols': 'ondemand', 06:30:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:30:15 INFO - 'tooltool.py': '/tools/tooltool.py', 06:30:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:30:15 INFO - '/tools/misc-python/virtualenv.py')}, 06:30:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:30:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:30:15 INFO - 'installer_path': 'installer.exe', 06:30:15 INFO - 'log_level': 'info', 06:30:15 INFO - 'log_name': 'talos', 06:30:15 INFO - 'log_to_console': True, 06:30:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:30:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:30:15 INFO - 'opt_config_files': (), 06:30:15 INFO - 'pip_index': False, 06:30:15 INFO - 'sps_profile': False, 06:30:15 INFO - 'sps_profile_interval': 0, 06:30:15 INFO - 'suite': 'dromaeojs-e10s', 06:30:15 INFO - 'system_bits': '32', 06:30:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:30:15 INFO - 'title': 'talos-linux64-ix-007', 06:30:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:30:15 INFO - 'use_talos_json': True, 06:30:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:30:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:30:15 INFO - 'work_dir': 'build'} 06:30:15 INFO - ##### 06:30:15 INFO - ##### Running clobber step. 06:30:15 INFO - ##### 06:30:15 INFO - Running pre-action listener: _resource_record_pre_action 06:30:15 INFO - Running main action method: clobber 06:30:15 INFO - rmtree: /builds/slave/test/build 06:30:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:30:16 INFO - Running post-action listener: _resource_record_post_action 06:30:16 INFO - ##### 06:30:16 INFO - ##### Running read-buildbot-config step. 06:30:16 INFO - ##### 06:30:16 INFO - Running pre-action listener: _resource_record_pre_action 06:30:16 INFO - Running main action method: read_buildbot_config 06:30:16 INFO - Using buildbot properties: 06:30:16 INFO - { 06:30:16 INFO - "project": "", 06:30:16 INFO - "product": "firefox", 06:30:16 INFO - "script_repo_revision": "production", 06:30:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:30:16 INFO - "repository": "", 06:30:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 06:30:16 INFO - "buildid": "20160421055405", 06:30:16 INFO - "pgo_build": "False", 06:30:16 INFO - "basedir": "/builds/slave/test", 06:30:16 INFO - "buildnumber": 1425, 06:30:16 INFO - "slavename": "talos-linux64-ix-007", 06:30:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:30:16 INFO - "platform": "ubuntu64_hw", 06:30:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:30:16 INFO - "branch": "fx-team", 06:30:16 INFO - "repo_path": "integration/fx-team", 06:30:16 INFO - "revision": "adc7dd34508b4133a986bee775b6a75552e13ecb", 06:30:16 INFO - "stage_platform": "linux64", 06:30:16 INFO - "builduid": "904aef4727814550a5512537981812d9", 06:30:16 INFO - "slavebuilddir": "test" 06:30:16 INFO - } 06:30:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 06:30:16 INFO - Running post-action listener: _resource_record_post_action 06:30:16 INFO - ##### 06:30:16 INFO - ##### Running download-and-extract step. 06:30:16 INFO - ##### 06:30:16 INFO - Running pre-action listener: _resource_record_pre_action 06:30:16 INFO - Running main action method: download_and_extract 06:30:16 INFO - mkdir: /builds/slave/test/build/tests 06:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:30:16 INFO - https://queue.taskcluster.net/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:30:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:30:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:30:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/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:30:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/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:30:21 INFO - Downloaded 1361 bytes. 06:30:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:30:21 INFO - Using the following test package requirements: 06:30:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:30:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:30:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:30:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:21 INFO - u'jsshell-linux-x86_64.zip'], 06:30:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:30:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:30:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:30:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:30:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:30:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:30:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:30:21 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:30:21 INFO - https://queue.taskcluster.net/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:30:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:30:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:30:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/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:30:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/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:30:22 INFO - Downloaded 22275480 bytes. 06:30:22 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:30:22 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:30:23 INFO - Return code: 0 06:30:23 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:30:23 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:30:23 INFO - https://queue.taskcluster.net/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:30:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:30:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:30:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/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:30:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/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:30:36 INFO - Downloaded 22275480 bytes. 06:30:36 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:30:36 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:30:37 INFO - Return code: 0 06:30: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:30:37 INFO - https://queue.taskcluster.net/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:30:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:30:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:30:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/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:30:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/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:30:38 INFO - Downloaded 10845952 bytes. 06:30:38 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:30:38 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:30:39 INFO - Return code: 0 06:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:30:39 INFO - https://queue.taskcluster.net/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:30:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:30:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:30:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/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:30:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OE9IN3UwTniw107f5n-yZg/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:30:40 INFO - Downloaded 54620862 bytes. 06:30:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:30:40 INFO - mkdir: /builds/slave/test/properties 06:30:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:30:40 INFO - Writing to file /builds/slave/test/properties/build_url 06:30:40 INFO - Contents: 06:30:40 INFO - build_url:https://queue.taskcluster.net/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:30:41 INFO - Running post-action listener: _resource_record_post_action 06:30:41 INFO - Running post-action listener: set_extra_try_arguments 06:30:41 INFO - ##### 06:30:41 INFO - ##### Running populate-webroot step. 06:30:41 INFO - ##### 06:30:41 INFO - Running pre-action listener: _resource_record_pre_action 06:30:41 INFO - Running main action method: populate_webroot 06:30:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:30:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:30:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:30:41 INFO - '--tppagecycles', 06:30:41 INFO - '7'], 06:30:41 INFO - 'tests': ['tsvgm']}}, 06:30:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:30:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:30:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:30:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:30:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:30:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:30:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:41 INFO - 'talos_options': ['--disable-e10s'], 06:30:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:30:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:30:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:41 INFO - 'talos_options': ['--disable-e10s'], 06:30:41 INFO - 'tests': ['damp', 'tps']}, 06:30:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:41 INFO - 'tests': ['damp', 'tps']}, 06:30:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:30:41 INFO - 'tests': ['dromaeo_dom']}, 06:30:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:30:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:30:41 INFO - 'tests': ['a11yr', 06:30:41 INFO - 'ts_paint', 06:30:41 INFO - 'tpaint', 06:30:41 INFO - 'sessionrestore', 06:30:41 INFO - 'sessionrestore_no_auto_restore', 06:30:41 INFO - 'tabpaint']}, 06:30:41 INFO - 'other-e10s': {'tests': ['a11yr', 06:30:41 INFO - 'ts_paint', 06:30:41 INFO - 'tpaint', 06:30:41 INFO - 'sessionrestore', 06:30:41 INFO - 'sessionrestore_no_auto_restore', 06:30:41 INFO - 'tabpaint']}, 06:30:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:30:41 INFO - 'ts_paint', 06:30:41 INFO - 'tpaint', 06:30:41 INFO - 'sessionrestore', 06:30:41 INFO - 'sessionrestore_no_auto_restore', 06:30:41 INFO - 'tabpaint']}, 06:30:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:30:41 INFO - 'ts_paint', 06:30:41 INFO - 'tpaint', 06:30:41 INFO - 'sessionrestore', 06:30:41 INFO - 'sessionrestore_no_auto_restore', 06:30:41 INFO - 'tabpaint']}, 06:30:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:30:41 INFO - 'tests': ['a11yr', 06:30:41 INFO - 'ts_paint', 06:30:41 INFO - 'tpaint', 06:30:41 INFO - 'sessionrestore', 06:30:41 INFO - 'sessionrestore_no_auto_restore', 06:30:41 INFO - 'tabpaint']}, 06:30:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:30:41 INFO - 'tests': ['a11yr', 06:30:41 INFO - 'ts_paint', 06:30:41 INFO - 'tpaint', 06:30:41 INFO - 'sessionrestore', 06:30:41 INFO - 'sessionrestore_no_auto_restore', 06:30:41 INFO - 'tabpaint']}, 06:30:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:30:41 INFO - 'tests': ['tsvgx', 06:30:41 INFO - 'tsvgr_opacity', 06:30:41 INFO - 'tart', 06:30:41 INFO - 'tscrollx', 06:30:41 INFO - 'cart']}, 06:30:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:30:41 INFO - 'tsvgr_opacity', 06:30:41 INFO - 'tart', 06:30:41 INFO - 'tscrollx', 06:30:41 INFO - 'cart']}, 06:30:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:41 INFO - 'talos_options': ['--disable-e10s'], 06:30:41 INFO - 'tests': ['tp5o']}, 06:30:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:41 INFO - 'tests': ['tp5o']}, 06:30:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:41 INFO - 'talos_options': ['--disable-e10s', 06:30:41 INFO - '--xperf_path', 06:30:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:30:41 INFO - 'tests': ['tp5n']}, 06:30:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:41 INFO - 'talos_options': ['--xperf_path', 06:30:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:30:41 INFO - 'tests': ['tp5n']}}, 06:30:41 INFO - 'talos.zip': {'path': '', 06:30:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:30:41 INFO - Running post-action listener: _resource_record_post_action 06:30:41 INFO - ##### 06:30:41 INFO - ##### Running create-virtualenv step. 06:30:41 INFO - ##### 06:30:41 INFO - Running pre-action listener: _resource_record_pre_action 06:30:41 INFO - Running main action method: create_virtualenv 06:30:41 INFO - Creating virtualenv /builds/slave/test/build/venv 06:30:41 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:30:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:30:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:30:41 INFO - Using real prefix '/usr' 06:30:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:30:42 INFO - Installing distribute.............................................................................................................................................................................................done. 06:30:43 INFO - Installing pip.................done. 06:30:43 INFO - Return code: 0 06:30:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f485c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296b640>, '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 0x296c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296c9d0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', '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:30:44 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:30:44 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:30:44 INFO - Using env: {'DISPLAY': ':0', 06:30:44 INFO - 'HOME': '/home/cltbld', 06:30:44 INFO - 'LANG': 'en_US.UTF-8', 06:30:44 INFO - 'LANGUAGE': 'en_US:en', 06:30:44 INFO - 'LOGNAME': 'cltbld', 06:30:44 INFO - 'MAIL': '/var/mail/cltbld', 06:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:44 INFO - 'MOZ_NO_REMOTE': '1', 06:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:44 INFO - 'NO_EM_RESTART': '1', 06:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:44 INFO - 'PWD': '/builds/slave/test', 06:30:44 INFO - 'SHELL': '/bin/bash', 06:30:44 INFO - 'SHLVL': '1', 06:30:44 INFO - 'TERM': 'linux', 06:30:44 INFO - 'TMOUT': '86400', 06:30:44 INFO - 'USER': 'cltbld', 06:30:44 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', 06:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:44 INFO - '_': '/tools/buildbot/bin/python'} 06:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:44 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:30:44 INFO - Cleaning up... 06:30:44 INFO - Return code: 0 06:30:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:44 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 0x7f3f485c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296b640>, '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 0x296c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296c9d0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', '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:30:44 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:30:44 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:30:44 INFO - Using env: {'DISPLAY': ':0', 06:30:44 INFO - 'HOME': '/home/cltbld', 06:30:44 INFO - 'LANG': 'en_US.UTF-8', 06:30:44 INFO - 'LANGUAGE': 'en_US:en', 06:30:44 INFO - 'LOGNAME': 'cltbld', 06:30:44 INFO - 'MAIL': '/var/mail/cltbld', 06:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:44 INFO - 'MOZ_NO_REMOTE': '1', 06:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:44 INFO - 'NO_EM_RESTART': '1', 06:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:44 INFO - 'PWD': '/builds/slave/test', 06:30:44 INFO - 'SHELL': '/bin/bash', 06:30:44 INFO - 'SHLVL': '1', 06:30:44 INFO - 'TERM': 'linux', 06:30:44 INFO - 'TMOUT': '86400', 06:30:44 INFO - 'USER': 'cltbld', 06:30:44 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', 06:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:44 INFO - '_': '/tools/buildbot/bin/python'} 06:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:44 INFO - Downloading/unpacking psutil>=0.7.1 06:30:44 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:30:44 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:30:44 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:30:44 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:30:44 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:30:44 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:30:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:30:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:30:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:30:46 INFO - Installing collected packages: psutil 06:30:46 INFO - Running setup.py install for psutil 06:30:46 INFO - building 'psutil._psutil_linux' extension 06:30:46 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:30:46 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:30:46 INFO - building 'psutil._psutil_posix' extension 06:30:46 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:30:46 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:30:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:30:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:30:46 INFO - Successfully installed psutil 06:30:46 INFO - Cleaning up... 06:30:47 INFO - Return code: 0 06:30:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:30: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:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30: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:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30: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', '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 0x7f3f485c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296b640>, '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 0x296c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296c9d0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', '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:30: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:30: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 mozsystemmonitor==0.0.0 06:30:47 INFO - Using env: {'DISPLAY': ':0', 06:30:47 INFO - 'HOME': '/home/cltbld', 06:30:47 INFO - 'LANG': 'en_US.UTF-8', 06:30:47 INFO - 'LANGUAGE': 'en_US:en', 06:30:47 INFO - 'LOGNAME': 'cltbld', 06:30:47 INFO - 'MAIL': '/var/mail/cltbld', 06:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:47 INFO - 'MOZ_NO_REMOTE': '1', 06:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:47 INFO - 'NO_EM_RESTART': '1', 06:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:47 INFO - 'PWD': '/builds/slave/test', 06:30:47 INFO - 'SHELL': '/bin/bash', 06:30:47 INFO - 'SHLVL': '1', 06:30:47 INFO - 'TERM': 'linux', 06:30:47 INFO - 'TMOUT': '86400', 06:30:47 INFO - 'USER': 'cltbld', 06:30:47 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', 06:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:47 INFO - '_': '/tools/buildbot/bin/python'} 06:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:30: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:30: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:30: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:30: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:30: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:30: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:30:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:30:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:30:49 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:30:49 INFO - Installing collected packages: mozsystemmonitor 06:30:49 INFO - Running setup.py install for mozsystemmonitor 06:30:49 INFO - Successfully installed mozsystemmonitor 06:30:49 INFO - Cleaning up... 06:30:49 INFO - Return code: 0 06:30:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f485c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296b640>, '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 0x296c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296c9d0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', '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:30:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:30:49 INFO - Using env: {'DISPLAY': ':0', 06:30:49 INFO - 'HOME': '/home/cltbld', 06:30:49 INFO - 'LANG': 'en_US.UTF-8', 06:30:49 INFO - 'LANGUAGE': 'en_US:en', 06:30:49 INFO - 'LOGNAME': 'cltbld', 06:30:49 INFO - 'MAIL': '/var/mail/cltbld', 06:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:49 INFO - 'MOZ_NO_REMOTE': '1', 06:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:49 INFO - 'NO_EM_RESTART': '1', 06:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:49 INFO - 'PWD': '/builds/slave/test', 06:30:49 INFO - 'SHELL': '/bin/bash', 06:30:49 INFO - 'SHLVL': '1', 06:30:49 INFO - 'TERM': 'linux', 06:30:49 INFO - 'TMOUT': '86400', 06:30:49 INFO - 'USER': 'cltbld', 06:30:49 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', 06:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:49 INFO - '_': '/tools/buildbot/bin/python'} 06:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:50 INFO - Downloading/unpacking blobuploader==1.2.4 06:30: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:30: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:30: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:30: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:30: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:30: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:30:52 INFO - Downloading blobuploader-1.2.4.tar.gz 06:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:30:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:30:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:30:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:30:53 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:30:53 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:30:53 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:30:53 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:30:53 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:30:53 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:30:53 INFO - Downloading docopt-0.6.1.tar.gz 06:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:30:53 INFO - Installing collected packages: blobuploader, requests, docopt 06:30:53 INFO - Running setup.py install for blobuploader 06:30:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:30:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:30:53 INFO - Running setup.py install for requests 06:30:54 INFO - Running setup.py install for docopt 06:30:54 INFO - Successfully installed blobuploader requests docopt 06:30:54 INFO - Cleaning up... 06:30:54 INFO - Return code: 0 06:30:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:30: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:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30: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:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:54 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 0x7f3f485c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296b640>, '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 0x296c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296c9d0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', '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:30:54 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:30:54 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:30:54 INFO - Using env: {'DISPLAY': ':0', 06:30:54 INFO - 'HOME': '/home/cltbld', 06:30:54 INFO - 'LANG': 'en_US.UTF-8', 06:30:54 INFO - 'LANGUAGE': 'en_US:en', 06:30:54 INFO - 'LOGNAME': 'cltbld', 06:30:54 INFO - 'MAIL': '/var/mail/cltbld', 06:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:54 INFO - 'MOZ_NO_REMOTE': '1', 06:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:54 INFO - 'NO_EM_RESTART': '1', 06:30:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:54 INFO - 'PWD': '/builds/slave/test', 06:30:54 INFO - 'SHELL': '/bin/bash', 06:30:54 INFO - 'SHLVL': '1', 06:30:54 INFO - 'TERM': 'linux', 06:30:54 INFO - 'TMOUT': '86400', 06:30:54 INFO - 'USER': 'cltbld', 06:30:54 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', 06:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:54 INFO - '_': '/tools/buildbot/bin/python'} 06:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:30:54 INFO - Running setup.py (path:/tmp/pip-_3IKwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:30:54 INFO - Running setup.py (path:/tmp/pip-Lghpyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:30:54 INFO - Running setup.py (path:/tmp/pip-xR7l48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:30:55 INFO - Running setup.py (path:/tmp/pip-l7FFC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:30:55 INFO - Running setup.py (path:/tmp/pip-YAPGAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:30:55 INFO - Running setup.py (path:/tmp/pip-4vsDIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:30:55 INFO - Running setup.py (path:/tmp/pip-i4RgVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:30:55 INFO - Running setup.py (path:/tmp/pip-BohBcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:30:55 INFO - Running setup.py (path:/tmp/pip-YVwHkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:30:55 INFO - Running setup.py (path:/tmp/pip-nFvUyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:30:55 INFO - Running setup.py (path:/tmp/pip-lrXx7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:30:55 INFO - Running setup.py (path:/tmp/pip-wEYGwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:30:55 INFO - Running setup.py (path:/tmp/pip-JLzqbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:30:55 INFO - Running setup.py (path:/tmp/pip-75k99t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:30:55 INFO - Running setup.py (path:/tmp/pip-VmssMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:30:55 INFO - Running setup.py (path:/tmp/pip-vI3fp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:30:55 INFO - Running setup.py (path:/tmp/pip-eTJM5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:30:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:30:56 INFO - Running setup.py install for manifestparser 06:30:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:30:56 INFO - Running setup.py install for mozcrash 06:30:56 INFO - Running setup.py install for mozdebug 06:30:56 INFO - Running setup.py install for mozdevice 06:30:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:30:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:30:56 INFO - Running setup.py install for mozfile 06:30:56 INFO - Running setup.py install for mozhttpd 06:30:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:30:56 INFO - Running setup.py install for mozinfo 06:30:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:30:56 INFO - Running setup.py install for mozInstall 06:30:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:30:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:30:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:30:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:30:56 INFO - Running setup.py install for mozleak 06:30:56 INFO - Running setup.py install for mozlog 06:30:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:30:57 INFO - Running setup.py install for moznetwork 06:30:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:30:57 INFO - Running setup.py install for mozprocess 06:30:57 INFO - Running setup.py install for mozprofile 06:30:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:30:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:30:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:30:57 INFO - Running setup.py install for mozrunner 06:30:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:30:57 INFO - Running setup.py install for mozscreenshot 06:30:57 INFO - Running setup.py install for moztest 06:30:57 INFO - Running setup.py install for mozversion 06:30:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:30:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:30:57 INFO - Cleaning up... 06:30:57 INFO - Return code: 0 06:30:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:30:57 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:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:57 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:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:57 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 0x7f3f485c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296b640>, '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 0x296c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296c9d0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', '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:30:57 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:30:57 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:30:57 INFO - Using env: {'DISPLAY': ':0', 06:30:57 INFO - 'HOME': '/home/cltbld', 06:30:57 INFO - 'LANG': 'en_US.UTF-8', 06:30:57 INFO - 'LANGUAGE': 'en_US:en', 06:30:57 INFO - 'LOGNAME': 'cltbld', 06:30:57 INFO - 'MAIL': '/var/mail/cltbld', 06:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:57 INFO - 'MOZ_NO_REMOTE': '1', 06:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:57 INFO - 'NO_EM_RESTART': '1', 06:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:57 INFO - 'PWD': '/builds/slave/test', 06:30:57 INFO - 'SHELL': '/bin/bash', 06:30:57 INFO - 'SHLVL': '1', 06:30:57 INFO - 'TERM': 'linux', 06:30:57 INFO - 'TMOUT': '86400', 06:30:57 INFO - 'USER': 'cltbld', 06:30:57 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', 06:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:57 INFO - '_': '/tools/buildbot/bin/python'} 06:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:30:58 INFO - Running setup.py (path:/tmp/pip-aPRH9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:30:58 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:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:30:58 INFO - Running setup.py (path:/tmp/pip-yinj_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:30:58 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:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:30:58 INFO - Running setup.py (path:/tmp/pip-lsiys9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:30:58 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:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:30:58 INFO - Running setup.py (path:/tmp/pip-_Up2sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:30:58 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:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:30:58 INFO - Running setup.py (path:/tmp/pip-dkeaq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:30:58 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:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:30:58 INFO - Running setup.py (path:/tmp/pip-82vevF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:30:58 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:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:30:58 INFO - Running setup.py (path:/tmp/pip-u5moKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:30:58 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:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:30:58 INFO - Running setup.py (path:/tmp/pip-goamT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:30:58 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:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:30:58 INFO - Running setup.py (path:/tmp/pip-WefLj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:30:58 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:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:30:58 INFO - Running setup.py (path:/tmp/pip-PJelbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:30:58 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:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:30:58 INFO - Running setup.py (path:/tmp/pip-8QLM0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:30:58 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:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:30:58 INFO - Running setup.py (path:/tmp/pip-LHIyyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:30:58 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:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:30:58 INFO - Running setup.py (path:/tmp/pip-S_3AsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:30:58 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:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:30:58 INFO - Running setup.py (path:/tmp/pip-_F1Jef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:30:59 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:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:30:59 INFO - Running setup.py (path:/tmp/pip-2c9dyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:30:59 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:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:30:59 INFO - Running setup.py (path:/tmp/pip-orYzd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:30:59 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:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:30:59 INFO - Running setup.py (path:/tmp/pip-Jf2oNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:30:59 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:30:59 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:30:59 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:30:59 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:30:59 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:30:59 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:30:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:30:59 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:30:59 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:30:59 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:30:59 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:30:59 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:30:59 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:31:01 INFO - Downloading blessings-1.6.tar.gz 06:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:31:01 INFO - Installing collected packages: blessings 06:31:01 INFO - Running setup.py install for blessings 06:31:01 INFO - Successfully installed blessings 06:31:01 INFO - Cleaning up... 06:31:01 INFO - Return code: 0 06:31:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:31:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:31:02 INFO - Reading from file tmpfile_stdout 06:31:02 INFO - Current package versions: 06:31:02 INFO - argparse == 1.2.1 06:31:02 INFO - blessings == 1.6 06:31:02 INFO - blobuploader == 1.2.4 06:31:02 INFO - docopt == 0.6.1 06:31:02 INFO - manifestparser == 1.1 06:31:02 INFO - mozInstall == 1.12 06:31:02 INFO - mozcrash == 0.17 06:31:02 INFO - mozdebug == 0.1 06:31:02 INFO - mozdevice == 0.48 06:31:02 INFO - mozfile == 1.2 06:31:02 INFO - mozhttpd == 0.7 06:31:02 INFO - mozinfo == 0.9 06:31:02 INFO - mozleak == 0.1 06:31:02 INFO - mozlog == 3.1 06:31:02 INFO - moznetwork == 0.27 06:31:02 INFO - mozprocess == 0.22 06:31:02 INFO - mozprofile == 0.28 06:31:02 INFO - mozrunner == 6.11 06:31:02 INFO - mozscreenshot == 0.1 06:31:02 INFO - mozsystemmonitor == 0.0 06:31:02 INFO - moztest == 0.7 06:31:02 INFO - mozversion == 1.4 06:31:02 INFO - psutil == 3.1.1 06:31:02 INFO - requests == 1.2.3 06:31:02 INFO - wsgiref == 0.1.2 06:31:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:02 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 0x7f3f485c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296b640>, '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 0x296c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296c9d0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', '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:31:02 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:31:02 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:31:02 INFO - Using env: {'DISPLAY': ':0', 06:31:02 INFO - 'HOME': '/home/cltbld', 06:31:02 INFO - 'LANG': 'en_US.UTF-8', 06:31:02 INFO - 'LANGUAGE': 'en_US:en', 06:31:02 INFO - 'LOGNAME': 'cltbld', 06:31:02 INFO - 'MAIL': '/var/mail/cltbld', 06:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:02 INFO - 'MOZ_NO_REMOTE': '1', 06:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:02 INFO - 'NO_EM_RESTART': '1', 06:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:02 INFO - 'PWD': '/builds/slave/test', 06:31:02 INFO - 'SHELL': '/bin/bash', 06:31:02 INFO - 'SHLVL': '1', 06:31:02 INFO - 'TERM': 'linux', 06:31:02 INFO - 'TMOUT': '86400', 06:31:02 INFO - 'USER': 'cltbld', 06:31:02 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', 06:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:02 INFO - '_': '/tools/buildbot/bin/python'} 06:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:02 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:31:02 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:31:02 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:31:02 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:31:02 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:31:02 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:31:02 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:31:02 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:31:02 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:31:02 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:31:02 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:31:02 INFO - Cleaning up... 06:31:02 INFO - Return code: 0 06:31:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:02 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 0x7f3f485c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296b640>, '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 0x296c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296c9d0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', '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:31:02 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:31:02 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:31:02 INFO - Using env: {'DISPLAY': ':0', 06:31:02 INFO - 'HOME': '/home/cltbld', 06:31:02 INFO - 'LANG': 'en_US.UTF-8', 06:31:02 INFO - 'LANGUAGE': 'en_US:en', 06:31:02 INFO - 'LOGNAME': 'cltbld', 06:31:02 INFO - 'MAIL': '/var/mail/cltbld', 06:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:02 INFO - 'MOZ_NO_REMOTE': '1', 06:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:02 INFO - 'NO_EM_RESTART': '1', 06:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:02 INFO - 'PWD': '/builds/slave/test', 06:31:02 INFO - 'SHELL': '/bin/bash', 06:31:02 INFO - 'SHLVL': '1', 06:31:02 INFO - 'TERM': 'linux', 06:31:02 INFO - 'TMOUT': '86400', 06:31:02 INFO - 'USER': 'cltbld', 06:31:02 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', 06:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:02 INFO - '_': '/tools/buildbot/bin/python'} 06:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:02 INFO - Downloading/unpacking jsonschema 06:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:31:04 INFO - Downloading/unpacking functools32 (from jsonschema) 06:31:04 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:31:04 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:31:04 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:31:04 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:31:04 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:31:04 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:31:05 INFO - Downloading functools32-3.2.3-2.tar.gz 06:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:31:05 INFO - warning: no files found matching '*.txt' 06:31:05 INFO - no previously-included directories found matching 'build' 06:31:05 INFO - no previously-included directories found matching 'dist' 06:31:05 INFO - no previously-included directories found matching '.git*' 06:31:05 INFO - Installing collected packages: jsonschema, functools32 06:31:05 INFO - Running setup.py install for functools32 06:31:05 INFO - warning: no files found matching '*.txt' 06:31:05 INFO - no previously-included directories found matching 'build' 06:31:05 INFO - no previously-included directories found matching 'dist' 06:31:05 INFO - no previously-included directories found matching '.git*' 06:31:05 INFO - Successfully installed jsonschema functools32 06:31:05 INFO - Cleaning up... 06:31:05 INFO - Return code: 0 06:31:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f485c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dc7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296b640>, '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 0x296c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296c9d0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', '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:31:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:31:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:31:05 INFO - Using env: {'DISPLAY': ':0', 06:31:05 INFO - 'HOME': '/home/cltbld', 06:31:05 INFO - 'LANG': 'en_US.UTF-8', 06:31:05 INFO - 'LANGUAGE': 'en_US:en', 06:31:05 INFO - 'LOGNAME': 'cltbld', 06:31:05 INFO - 'MAIL': '/var/mail/cltbld', 06:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:05 INFO - 'MOZ_NO_REMOTE': '1', 06:31:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:05 INFO - 'NO_EM_RESTART': '1', 06:31:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:05 INFO - 'PWD': '/builds/slave/test', 06:31:05 INFO - 'SHELL': '/bin/bash', 06:31:05 INFO - 'SHLVL': '1', 06:31:05 INFO - 'TERM': 'linux', 06:31:05 INFO - 'TMOUT': '86400', 06:31:05 INFO - 'USER': 'cltbld', 06:31:05 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', 06:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:05 INFO - '_': '/tools/buildbot/bin/python'} 06:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:05 INFO - Downloading/unpacking flake8 06:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:31:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:31:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:31:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:31:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:31:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:31:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:31:08 INFO - no previously-included directories found matching 'docs/_build' 06:31:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:31:08 INFO - Running setup.py install for pep8 06:31:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:31:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:31:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:31:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:31:08 INFO - no previously-included directories found matching 'docs/_build' 06:31:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:31:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:31:08 INFO - Cleaning up... 06:31:08 INFO - Return code: 0 06:31:08 INFO - Running post-action listener: _resource_record_post_action 06:31:08 INFO - Running post-action listener: _start_resource_monitoring 06:31:08 INFO - Starting resource monitoring. 06:31:08 INFO - ##### 06:31:08 INFO - ##### Running install step. 06:31:08 INFO - ##### 06:31:08 INFO - Running pre-action listener: _resource_record_pre_action 06:31:08 INFO - Running main action method: install 06:31:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:31:08 INFO - Reading from file tmpfile_stdout 06:31:08 INFO - Detecting whether we're running mozinstall >=1.0... 06:31:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:31:08 INFO - Reading from file tmpfile_stdout 06:31:08 INFO - Output received: 06:31:08 INFO - Usage: mozinstall [options] installer 06:31:08 INFO - Options: 06:31:08 INFO - -h, --help show this help message and exit 06:31:08 INFO - -d DEST, --destination=DEST 06:31:08 INFO - Directory to install application into. [default: 06:31:08 INFO - "/builds/slave/test"] 06:31:08 INFO - --app=APP Application being installed. [default: firefox] 06:31:08 INFO - mkdir: /builds/slave/test/build/application 06:31:08 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:31:08 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:31:24 INFO - Reading from file tmpfile_stdout 06:31:24 INFO - Output received: 06:31:24 INFO - /builds/slave/test/build/application/firefox/firefox 06:31:24 INFO - Running post-action listener: _resource_record_post_action 06:31:24 INFO - ##### 06:31:24 INFO - ##### Running run-tests step. 06:31:24 INFO - ##### 06:31:24 INFO - Running pre-action listener: _resource_record_pre_action 06:31:24 INFO - Running main action method: run_tests 06:31:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:31:24 INFO - Python 2.7.3 06:31:24 INFO - Return code: 0 06:31:24 INFO - grabbing minidump binary from tooltool 06:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:24 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 0x296b640>, '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 0x296c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296c9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:31:24 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:31:24 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:31:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:31:24 INFO - Return code: 0 06:31:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:31:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:31:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:31:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:31:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:31:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:31:25 INFO - Return code: 0 06:31:25 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/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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:31:25 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/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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:31:25 INFO - Using env: {'DISPLAY': ':0', 06:31:25 INFO - 'HOME': '/home/cltbld', 06:31:25 INFO - 'LANG': 'en_US.UTF-8', 06:31:25 INFO - 'LANGUAGE': 'en_US:en', 06:31:25 INFO - 'LOGNAME': 'cltbld', 06:31:25 INFO - 'MAIL': '/var/mail/cltbld', 06:31:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:31:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:25 INFO - 'MOZ_NO_REMOTE': '1', 06:31:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:25 INFO - 'NO_EM_RESTART': '1', 06:31:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:25 INFO - 'PWD': '/builds/slave/test', 06:31:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:31:25 INFO - 'SHELL': '/bin/bash', 06:31:25 INFO - 'SHLVL': '1', 06:31:25 INFO - 'TERM': 'linux', 06:31:25 INFO - 'TMOUT': '86400', 06:31:25 INFO - 'USER': 'cltbld', 06:31:25 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260', 06:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:25 INFO - '_': '/tools/buildbot/bin/python'} 06:31:25 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/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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:31:26 INFO - mozversion application_buildid: 20160421055405 06:31:26 INFO - mozversion application_changeset: adc7dd34508b4133a986bee775b6a75552e13ecb 06:31:26 INFO - mozversion application_display_name: Nightly 06:31:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:31:26 INFO - mozversion application_name: Firefox 06:31:26 INFO - mozversion application_remotingname: firefox 06:31:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:31:26 INFO - mozversion application_vendor: Mozilla 06:31:26 INFO - mozversion application_version: 48.0a1 06:31:26 INFO - mozversion platform_buildid: 20160421055405 06:31:26 INFO - mozversion platform_changeset: adc7dd34508b4133a986bee775b6a75552e13ecb 06:31:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:31:26 INFO - mozversion platform_version: 48.0a1 06:31:26 INFO - using testdate: 1461245486 06:31:26 INFO - actual date: 1461245486 06:31:26 INFO - starting webserver on 'localhost:45620' 06:31:26 INFO - SUITE-START | Running 2 tests 06:31:26 INFO - TEST-START | dromaeo_css 06:31:26 INFO - operating with platform_type : linux_ 06:31:26 INFO - Initialising browser for dromaeo_css test... 06:31:26 INFO - TEST-INFO | started process 32034 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdk4UFc/profile http://localhost:45620/getInfo.html) 06:31:30 INFO - PROCESS | 32034 | 06:31:30 INFO - PROCESS | 32034 | (process:32102): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:31:31 INFO - PROCESS | 32034 | __metrics Screen width/height:1600/1200 06:31:31 INFO - PROCESS | 32034 | colorDepth:24 06:31:31 INFO - PROCESS | 32034 | Browser inner width/height: 1024/697 06:31:31 INFO - PROCESS | 32034 | __metrics 06:31:31 ERROR - PROCESS | 32034 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:31:32 INFO - TEST-INFO | 32034: exit 0 06:31:32 INFO - Browser initialized. 06:31:32 INFO - Running cycle 1/1 for dromaeo_css test... 06:31:32 INFO - TEST-INFO | started process 32153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdk4UFc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:31:34 INFO - PROCESS | 32153 | 06:31:34 INFO - PROCESS | 32153 | (process:32215): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:31:44 INFO - PROCESS | 32153 | RSS: Main: 164831232 06:31:44 INFO - PROCESS | 32153 | 06:32:34 INFO - PROCESS | 32153 | 1461245554411 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:34:46 INFO - PROCESS | 32153 | Cycle 1(1): loaded http://localhost:45620/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45620/tests/dromaeo/cssquery-ext.html) 06:34:47 INFO - PROCESS | 32153 | RSS: Main: 167534592 06:34:47 INFO - PROCESS | 32153 | 06:37:49 INFO - PROCESS | 32153 | Cycle 1(1): loaded http://localhost:45620/tests/dromaeo/cssquery-ext.html (next: http://localhost:45620/tests/dromaeo/cssquery-jquery.html) 06:37:49 INFO - PROCESS | 32153 | RSS: Main: 165502976 06:37:49 INFO - PROCESS | 32153 | 06:40:51 INFO - PROCESS | 32153 | Cycle 1(1): loaded http://localhost:45620/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45620/tests/dromaeo/cssquery-mootools.html) 06:40:52 INFO - PROCESS | 32153 | RSS: Main: 166739968 06:40:52 INFO - PROCESS | 32153 | 06:43:54 INFO - PROCESS | 32153 | Cycle 1(1): loaded http://localhost:45620/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45620/tests/dromaeo/cssquery-prototype.html) 06:43:54 INFO - PROCESS | 32153 | RSS: Main: 164491264 06:43:54 INFO - PROCESS | 32153 | 06:46:57 INFO - PROCESS | 32153 | Cycle 1(1): loaded http://localhost:45620/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45620/tests/dromaeo/cssquery-yui.html) 06:46:58 INFO - PROCESS | 32153 | RSS: Main: 165953536 06:46:58 INFO - PROCESS | 32153 | 06:50:00 INFO - PROCESS | 32153 | Cycle 1(1): loaded http://localhost:45620/tests/dromaeo/cssquery-yui.html (next: http://localhost:45620/tests/dromaeo/cssquery-dojo.html) 06:50:00 INFO - PROCESS | 32153 | RSS: Main: 168075264 06:50:00 INFO - PROCESS | 32153 | 06:50:00 INFO - PROCESS | 32153 | __start_tp_report 06:50:00 INFO - PROCESS | 32153 | _x_x_mozilla_page_load 06:50:00 INFO - PROCESS | 32153 | _x_x_mozilla_page_load_details 06:50:00 INFO - PROCESS | 32153 | |i|pagename|runs| 06:50:00 INFO - PROCESS | 32153 | |0;dojo.html;2579.690437147542;2634.723354047824;2655.296346468185;2666.173486219271;2680.0753739959705;4779.091972525218;4787.28190771384;4796.880077998052;4839.101607248243;4868.878278043051;4648.558386953243;4675.906481870361;4765.618750499961;4832.251001094827;4845.7819398127085;4342.826286948526;4367.58507941745;4433.2241857674935;4437.267850804614;4471.441069866267;4366.759828209447;4446.355278484618;4511.390962220091;4513.232750432418;4536.637069034469;4320.870373888788;4360.411344468488;4400.427944367244;4446.133004064192;4456.286994080931;4371.4972778130605;4374.562543745632;4386.583274588909;4403.383526306319;4436.977815110904;4350.825966961318;4351.608355248043;4366.759828209447;4405.140997505488;4408.691391602589;4479.4176757021705;4616.6537509686905;4661.09108723799;4668.603168730662;4685.648576356787;5094.1825631414295;5118.07874582575;5154.020736060136;5156.484351564814;5190.247414124969;4977.626677999128;5166.974165129188;5172.250023746573;5172.948270517322;5173.689578625257;4697.859064228079;4710.811567537328;4718.197906355927;4748.548887855648;4756.833510827174;5192.428832828386;5209.348831396075;5210.062188805976;5228.05894938907;5268.28878101459;4997.350344455198;4999.575036121898;5002.199648056294;5003.399592048904;5085.771140298695;5057.115004874206;5061.974690126526;5072.594192464594;5073.644844860824;5128.692278463304;4878.609711223094;4961.528654777862;5017.8243761468175;5027.296178534935;5057.544820966131;4854.927176092361;4992.90014199714;5005.774740136702;5053.140966035783;5135.281060651511;4210.073783767566;4215.304474761691;4223.345381465878;4254.532001479834;4261.573842615714;3728.9813550932613;3735.533058367704;3755.6432138946757;3768.491253680718;3776.716746243988;4302.139572085595;4413.404190434315;4484.551544845554;4494.595486406239;4498.190325741398;4999.725015124203;5007.749612519359;5030.119729047402;5045.990801839646;5053.418856831511;4404.273294906305;4410.250257456176;4410.845620403271;4412.0734645724115;4455.844045458393;4451.287793953017;4536.8638940831825;4588.311753236974;4601.28680054592;4627.652926030494;4772.904541909073;4777.402824646919;4794.544518270759;4800.303955926371;4803.711777293373;4882.90234195307;5042.798288068436;5050.267711181785;5056.443791182894;5099.5410413063;4818.7831547581145;4871.855114048125;4891.706497610155;4894.608431325414;4930.852074437773;5057.494250574913;5091.032703786417;5091.465396133352;5097.0315640028275;5142.460041695717;4933.33399991011;5078.339815823919;5159.871003224949;5165.405978312392;5169.095408303607;4835.975820120877;4905.583025442877;4988.501149884983;5002.52476014778;5009.949900500948;4951.480094590161;4970.478099799614;4974.825881094144;4979.551840334242;5008.2738002988635;4641.605463535638;4887;4897.510248975074;4899.559039686445;4901.1913034350355;5005.62457815658;5012.348394708664;5023.447420783784;5031.471695471922;5076.847694569169;4814.8796280093275;4856.927146092882;4865.95134048655;4866.440359358578;4880.877978050577 06:50:00 INFO - PROCESS | 32153 | |1;ext.html;540.5783488878674;559.5048382181769;576.3228206856942;601.6330038676404;611.571899670231;33250.501242481354;34312.31375372494;34326.65673343266;34351.14122146948;34464.48303275447;36317.63682363176;36995.260094798155;37096.258074838486;37243.62756372435;37271;7627.923720762805;7754.534727916315;7832.1776213497615;7839.529628222325;7874.881876771853;7692.615369231544;7816;7816.062072551302;7956.721514746985;7988.4408091433625;7915.881261781078;7998.920010799905;8021.839563208732;8022.077461091962;8029.2773650371455;7802.921970780305;7882.842343153134;7885.408594355417;7886.881696774553;7911.485753426066;7873.409494287951;7934.682612695486;7969.721059762938;7970.402219833536;7981;36923.4461483078;37282;37427.06432339186;37433;37457.62542374569;3153.274746808224;3234.207619133304;3249.366373557157;3277.655846136169;3302.290007648343;28173.29566760827;28595.85702071497;28749.42501149986;28996.27509312263;29108.563371549233;3457.5539496784686;3550.3254381667402;3590.935212252939;3593.82030898454;3604.1710406606367;228064;229437;230536;231280;231537;33653;50348.49651503511;50547.98904021899;50653.480395588194;50790;33054.669453305156;33079.50380744291;33159.502607460905;33253.16867078294;33255.50116748251;12846.871531284754;12926.870731292754;12972.221666700028;12995.610131696065;13103.868961310456;10689.786204275872;10710.46447677613;10713.035826775627;10758.569657213624;10765.300255483526;8071.112177660452;8074.313683336982;8171.10117887032;8189.918100819034;8204.466709663971;3219.6780321968085;3220.838958052088;3268.2156282492506;3271.329377477611;3282.343531293751;956.1633570625703;997.491279447487;1007.9064215326453;1027.1577306608658;1057.735566108473;28401;28903.421931561672;29345.853270733936;29505.90188030226;31056.844715776275;899.1098812175899;958.3579002068631;967.274544091931;981.8183636027215;995.3331268050424;13622.727545449035;14038.71922561543;14159.221242831743;14217.64455888611;14445.711085778226;324923;330113;330786;331685;332413;46452;47119.764401177774;47221.76389118032;47524.28713569299;47575.762121189175;1206.6440400081997;1228.7112528555783;1229.9938500307442;1239.60332693539;1263.134752694389;25491.36271593225;26719;26834.731652683222;26993.865030674722;27128;40767.59232407757;41456.79271603622;41653.58346416497;41697;41801.79099104485;235339;236326;238259;317606;319007;24864.875675621504;25196.622050668888;25209.873950630128;25246.116385926405;25262.242132736046;40158.397624036246;40698;40837.795811020755;41458.58541414547;41807.790961045;34040.82979585086;35292.294154117284;35736.821315893256;36324.45513317355;36451.63548364482;34049.65950340564;34716.30567388688;34869.825650871586;34882;35353.46969795404;35126.473102902964;35218.11954701153;35888.82055589705;37415.6258437423;37538.436923446716;27205.373113505648;30911;31073.37853242877;31089.222769430944;31227.84386078055;22730.02331233596;24079.638805418283;24232;24545.018199271828;24707.876460617583 06:50:00 INFO - PROCESS | 32153 | |2;jquery.html;368.60559201654223;372.9272791805597;373.96447337502934;374.99437508437376;386.9226154769047;15226.619334516628;15563.377464901405;16282;16345.34618615254;16388.590285242874;15610;16009.519714408558;16284.83715162848;16404.09777462239;16419.425320113798;4872.220444728853;5093.541581257705;5129.0767661820855;5137.871553211162;5150.690958542481;4980.87547811304;5046.571041461461;5060.924086138711;5077.263796749469;5085.440601533847;4931.358923339961;5222.138347172712;5238.109521381355;5247.842564723045;5253.369595648527;5053.64624476285;5169.172932330828;5217.739113044351;5345.1714984177515;5363.275957745694;5188.066148093341;5193.584513238932;5198.038362902875;5211.478852114796;5231.555317797992;11763.588274410355;11917.463714132798;12516.937415312865;12524.74950500994;12550.435230414654;1778.4042345814169;1870.9158087885942;2034.3083351660507;2152.924647637341;2181.596404665126;9378.296627752945;10171.542280597318;10293.073623373932;11802.232854864405;12520.499180032788;1692.3061544766585;1761.594833188361;1836.0636075601406;1864.3102052240622;1910.2645481489587;65168.348316516705;67645;67901.98147027798;68287.3171268286;70382.2961770386;8995.640174392951;9096.181343678969;9335.953320233355;9361.110694484014;9529.952350238205;12626.558070467674;12627.179233349803;12634.494620215271;12659.936700316439;12704.936475317565;6797.762078327334;6995.580265184105;7039.401650859631;7104.25405332443;7117.074780278531;6478.5141114415665;6584.078229047937;6605.933940660628;6682.63245521501;6825.522213445011;3935.0752573145287;3971.7219794614675;4052.452918855976;4052.5339585947404;4054.2499637567144;1867.738516607676;1888.3862744608057;1901.9334323298895;1914.2343062775;1921.0586812461793;822.198356602308;888.9822203555892;933.6918816790443;933.8365785987424;1006.1095930101766;15470.998746134766;15929.203539823195;16080.758788618181;16383.918080409521;16450.75323870143;864.883240762489;882.7440042387764;915.2769312243387;922.7231830450838;953.5422996961497;8795.47227166372;8925.553722313858;9012.594433250519;9163.49600771964;9181.265498760084;336680;370329;374657;380143;391011;69232.30767692359;74440;76563;77053.6147319271;78420;968.6900191938512;986.1174249047062;1002.7693630465034;1016.5019140621042;1017.8982101789762;14961.476348327757;14969.550913472613;15241.923790380977;15284.617884552976;15734.685306294039;33945.151371215914;34050.829745851115;34297;34683.65316346804;34720.305593888486;48907.75546122246;49071;49463.25805112854;49605.25592116049;49778;7463.328300452985;7629.427792915442;7643.770686879402;7688.884666729891;7778.222177782177;10958.39728814891;11258.59267591551;11432.657020289405;11799.705007374885;11821.172517923662;6213.782517611862;10451.32066415711;10507.211959102944;10585.629502967358;10815.729606759895;10137.695869123938;10181.389116653025;10645.467726613793;10782.946085269523;10831.2959657622;9828.803423931624;10154.289199755945;10349;10558.260921735406;11200.775984480102;7796.961015194887;7854.1360450349275;7886.44794864354;7924.326432253323;8008.599570021592;8083.555404452576;9756.219502439646;10651.946740266249;10758.731031723957;10951.178661600572 06:50:00 INFO - PROCESS | 32153 | |3;mootools.html;1461.050317293759;1461.7734251191066;1607.9598010049747;1680.4622520793337;1749.1166960684852;6727.529072964894;7601.58191299479;7612;7841.960790196048;7846.843063138734;7628.923710762891;7648.043994500687;7666.233376662345;7690.807729806757;7807.297343239107;2248.05581655705;2255.6842042114117;2268.671042698816;2268.965965510519;2283.200879692111;2109.725735654363;2111.2610586294827;2113.8625989310644;2145.131221855151;2226.2430773536994;2208.6024515587187;2224.699665545155;2238.664200369941;2262.4570103175283;2293.5183611441616;2237.4853783629856;2252.7296724393013;2258.06290389489;2258.54829034193;2267.104493724986;2037.6943458481198;2040.3470889315424;2043.4176259766043;2058.547119633693;2060.1450398084776;7840.372770178372;7886.842263154762;7896.210378962115;7908.565028923407;7941.245581669732;4494.235979883428;4629.120467111238;4632.791524381377;4660.557247061523;4694.037722266927;3022.7128422799797;3026.3039500914692;3141.8429078545983;3142.921426964321;3149.2126968257935;953.3279038277998;957.5595226195958;959.9664011759625;977.9804403911882;1007.6070332570304;10495.632652857113;10637.73405664857;10678.359298442118;10686.19853510982;10733.463326833706;4166.854160104382;4175.624193822509;4333.891652708708;4362.607365337135;4398.670099742532;9191.218746406497;9203.953980230055;9207.26341892647;9211.355205135576;9255.90744092564;4677.789499472532;4692.507286734844;4700.95299047012;4713.29300604912;4715.95284047162;3700.611435799256;4124.731892427043;4225.408442818008;4264.33902745075;4284.635805956528;3609.729270304685;3633.2733453309443;3662.102784817737;3753.9249215016093;3800.6959443244473;1164.9708757280966;1166.6674997625805;1178.7465694875643;1180.698921774942;1201.2732296960387;818.8157664525553;834.9271186525286;884.8584226523855;890.2521881619471;896.6054935828215;5390.865228369322;5423.2136340230445;5434.619576629677;5535.778568857281;5645.1532270159805;419.9333692421277;425.3407218810831;430.249215119612;432.595523185816;433.3607928305787;3801.9049523761573;3868.3423817951016;3922;3944.171723938005;3971.5631280559114;9263.675771347971;9451.76370590727;9473.24214062887;9548.427094374221;9568;8806.20744133031;9077.863832042525;9141.680041198659;9524.428534287965;9563.330566860392;7149.82125446868;7217.8917316240295;7236.782896513113;7260.528065675714;7268.127824660969;5426.8371948841595;5663.348714897675;5754.683492407958;5761.942380576308;5776.393478684678;8670.78323041929;8696.478211307342;8793.252573531321;8797.208251257418;8873.423227490193;8346.707865224687;8708.738737837875;8740.562971851508;8797.912020879709;8932.86600701003;6235.594686345373;6570.967145164243;6634.734610615521;6768.7292508299115;6999.265077166824;7269.091363579552;7303.269673032654;7314.232005639544;7348.706051758084;7428.405727541675;6527.5757075789925;6776.390124888783;6795.660216989229;6802.01370801241;6897.55165914214;6565.277819439762;6597.373249541286;6659.4006539411685;6713.966430167818;6720.1599800025;6459.806205813833;6476.805695829133;6541.215054193337;6558.278589355263;6565.310642382481;4623.12160689468;4673.634194791285;4732.455767586634;4817.759112044454;4819.879503012453;4753.572178503951;4803.687760295569;4820.060088282751;4840.685355451885;4879.194932836184 06:50:00 INFO - PROCESS | 32153 | |4;prototype.html;298.1636509590599;302.55071219239426;312.0902569011332;312.6576398843267;314.6790273920601;5081.187010078388;5222.8694282642955;5298.523132918037;5403.540699040582;5417.1603401472785;5310.230016647593;5333.093464062085;5334.279872217249;5339.332583427072;5392.973035134829;4090.0797320602924;4142.425878166293;4158.126793373395;4163.354680024601;4177.51958524769;4156.8129434175535;4159.188958153161;4177;4198.6850986176005;4200.075983283673;3841.4045822897497;4075.572064933169;4079.1433798902117;4091.1204091120403;4109.465769449967;4045.3122969095325;4053.817578208973;4069;4088.8773336799945;4089.7546147230964;3399.3031428557088;3553.466979953028;3556.1643013891717;3562.3765840977726;3566.4472006838982;5159.535641792219;5164.922526162073;5166.844994650167;5168.431472538018;5171.715555644438;4664.626829853638;4681.157391669498;4688.906221875577;4696.7651617419;4726.196546587088;5345.8773657531965;5628.465295796893;5650.576206784508;5656.981743286206;5657.717114144276;3874.2251549689895;3876.8369489153424;3885.3977633466575;3885.825137868803;3893.240818040483;5591.700896471101;5791.82624521265;5893.204417403638;5948.702564871739;5970.641761494324;3999.5200575930494;4003.3794761811964;4003.499562554681;4019.5578486366476;4024.879253622396;4040.333344998101;4040.9595904040584;4054.3310353791294;4066;4072.0430698785763;4593.747343896118;4677.134730074947;4688.882777930579;4694.389729335233;4697.6241900647865;5620.903923734914;5641.830745077655;5657.2928383952;5675.091985282335;5685.260916080966;1389.5483967710534;1406.219548150786;1413.2227274998709;1413.4699487692114;1423.9359228834728;903.7605034665819;935.6818681648136;944.8393773058597;947.772534591693;948.8434408322687;5015.247712843103;5018.268697299426;5025.522575355335;5030.673006254582;5036.093503169464;5860.326062502867;5861.3552509223955;5868.559858010666;5873.618214816023;5879.617824841372;4902.975485122552;4987.027529631687;4992.90014199714;5020.146575082172;5021.221710634857;3120.6879312068613;3127.8436078196;3132.4988001919583;3140.528920661919;3146.7325277351224;5492.423295553909;5508.173773933861;5520.613557051048;5521.171824226398;5547.667139971614;5792.536597072309;5975.940240597538;5998.1105951625095;6032.819015429544;6036.124761909498;5442.945570544323;5491.862703432446;5530.446955304518;5536.584756143306;5552.833414997556;5541.528970037431;5821.476067153976;5822.388649191774;5834.15404766315;5839.299284085937;5716.79991200306;5734.254546909042;5736.42635736423;5745.770169193185;5770.711464426846;5225.1378522543355;5311.575073994149;5491.643043202179;5516.751746171512;5556.277683901067;3924.156306394025;3944.6449819516383;3951.3085210087543;3953.545342285559;3956.6043395660204;5791.623544469596;5851.473367396955;5853.707314634166;5856.180134781219;5867.002609556301;5453.818472610988;5618.438156184512;5658.207850900795;5662.603617746719;5716.199732037601;5593.664380137205;5615.72563111924;5625.521830644441;5650;5654.123610840326;5392.379876314118;5550.222968784293;5552.250446189712;5568.303962004749;5572.331320241597;5675.808080303017;5679.346875109415;5693.886122277614;5714.200011998407;5715.742791574472;5532.5020748132865;5551.306086739158;5565.471280228372;5603;5605.859853503695 06:50:00 INFO - PROCESS | 32153 | |5;yui.html;717.1501770402077;731.3490993016214;733.6478490324644;769.3652736492395;798.4011991006745;11572.942135289322;11597;11697.941510292458;11749.295042297468;11949.044076473883;12057.939710301436;12076.879231207708;12093.395330233498;12149.635510934664;12158.939205303983;786.905571331441;815.7634286057037;820.9302209312216;826.0912995704737;827.4869580859876;822.1244374740882;823.7569916874536;830.779843341515;830.8546004449228;831.0982583896449;850.5194565070747;861.1474640106281;861.267922266072;862.241227719609;862.7411776467035;845.6152450634946;847.7922908887331;853.871919212117;856.8671855862289;858.7466697324304;620.218524658933;623.5230049012509;624.1916717850395;627.1408170805979;630.2625927664643;11678.299302041905;11718.941405293004;11723.296602203895;11736.35450050247;11761.88238117625;11902.166848320621;11962.342071186082;12044;12119.454624541917;12356.320402377865;9350.298727595458;9407.858882116774;9627;11581.768364632744;11856.110791690659;3251.3497300539752;3294.3740689269202;3294.67053294671;3295.653956334574;3328.9500657490157;47232.527674723155;47545.286820697715;47578.5242147581;47921.28118078197;47928;9018.143276388733;9067.81864362709;9225;9235.07649235071;9427;15393.538193854203;15400.460983865734;15491.84508154904;15526.1460619667;15589.454369097028;6174.629522228681;6364.968175159094;6403.58376705522;6442.130312407765;6492.156019717407;3635.4365073413665;3653.3606618841595;3704.6480584344445;3756.248750249906;3770.792606406619;2861.2846788302923;2921.4303210873677;2925.824450532975;2925.956110658342;2929.194471520349;484.15756583545084;488.3139189438844;493.5114236905438;493.8888750031286;494.40671194566664;565.5758181363977;595.4075694683818;603.1134232677956;659.6800551732406;672.6098862659645;7594.772156835304;7692;7734.7679569613;7761.379089672812;7890.132085470594;506.65294273422086;528.1233152966058;572.6856863498282;588.5438784941618;650.5316172355896;3574.088607405147;3709.647583479565;3744.5319335083113;3755.774653520743;3830.961690383116;50066.24900626494;51431.485685143416;51632;51864.48135518596;52716.736416317675;46159.30761038587;46397;46955.76522117368;47270.76364618155;47403.28895066577;39861.40207896884;40083.198336033696;41657.79171104125;41853;43007.13985720268;7277.345038946521;7316.890246646198;7477.40180785525;7505.6997720090585;7593.696252149852;27584.44831103407;27628.447431050863;28098.71901280961;28288.15135545937;28365;34087.147821304665;34739.826300868335;36029.27941441104;36536.81731591325;36597.817010914776;9659;9681.515924203903;9692.32153749259;9915.900840991499;10123.139533139765;10892.891071089187;11179.832302515631;11396.08831293478;11586.536538538365;11964.46159922823;10978.341299522055;11618.6514404568;11738.58914937973;12188.268703877795;12254.387280635754;11266.718332041764;11336.263142895685;11488.55113298156;11520.193586448868;11883.524659013543;11255.943720281346;11555;11559.537618495166;11590.652280431601;11722.824157637813;9328.860067099135;9491.145796878314;9551.570179342085;9688.224942004763;9912.603495860374;8931;9319.767005824908;9357;9446.149846513847;9539.952300238454 06:50:00 INFO - PROCESS | 32153 | __end_tp_report 06:50:00 INFO - PROCESS | 32153 | __start_cc_report 06:50:00 INFO - PROCESS | 32153 | _x_x_mozilla_cycle_collect,361 06:50:00 INFO - PROCESS | 32153 | __end_cc_report 06:50:00 INFO - PROCESS | 32153 | __startTimestamp1461246600815__endTimestamp 06:50:00 INFO - PROCESS | 32153 | 06:50:00 INFO - PROCESS | 32153 | ------- Summary: start ------- 06:50:00 INFO - PROCESS | 32153 | Number of tests: 6 06:50:00 INFO - PROCESS | 32153 | 06:50:00 INFO - PROCESS | 32153 | [#0] dojo.html Cycles:165 Average:4702.66 Median:4845.78 stddev:493.64 (10.2%) stddev-sans-first:466.21 06:50:00 INFO - PROCESS | 32153 | Values: 2579.7 2634.7 2655.3 2666.2 2680.1 4779.1 4787.3 4796.9 4839.1 4868.9 4648.6 4675.9 4765.6 4832.3 4845.8 4342.8 4367.6 4433.2 4437.3 4471.4 4366.8 4446.4 4511.4 4513.2 4536.6 4320.9 4360.4 4400.4 4446.1 4456.3 4371.5 4374.6 4386.6 4403.4 4437.0 4350.8 4351.6 4366.8 4405.1 4408.7 4479.4 4616.7 4661.1 4668.6 4685.6 5094.2 5118.1 5154.0 5156.5 5190.2 4977.6 5167.0 5172.3 5172.9 5173.7 4697.9 4710.8 4718.2 4748.5 4756.8 5192.4 5209.3 5210.1 5228.1 5268.3 4997.4 4999.6 5002.2 5003.4 5085.8 5057.1 5062.0 5072.6 5073.6 5128.7 4878.6 4961.5 5017.8 5027.3 5057.5 4854.9 4992.9 5005.8 5053.1 5135.3 4210.1 4215.3 4223.3 4254.5 4261.6 3729.0 3735.5 3755.6 3768.5 3776.7 4302.1 4413.4 4484.6 4494.6 4498.2 4999.7 5007.7 5030.1 5046.0 5053.4 4404.3 4410.3 4410.8 4412.1 4455.8 4451.3 4536.9 4588.3 4601.3 4627.7 4772.9 4777.4 4794.5 4800.3 4803.7 4882.9 5042.8 5050.3 5056.4 5099.5 4818.8 4871.9 4891.7 4894.6 4930.9 5057.5 5091.0 5091.5 5097.0 5142.5 4933.3 5078.3 5159.9 5165.4 5169.1 4836.0 4905.6 4988.5 5002.5 5009.9 4951.5 4970.5 4974.8 4979.6 5008.3 4641.6 4887.0 4897.5 4899.6 4901.2 5005.6 5012.3 5023.4 5031.5 5076.8 4814.9 4856.9 4866.0 4866.4 4880.9 06:50:00 INFO - PROCESS | 32153 | 06:50:00 INFO - PROCESS | 32153 | [#1] ext.html Cycles:180 Average:42167.35 Median:18961.02 stddev:73640.71 (388.4%) stddev-sans-first:73780.97 06:50:00 INFO - PROCESS | 32153 | Values: 540.6 559.5 576.3 601.6 611.6 33250.5 34312.3 34326.7 34351.1 34464.5 36317.6 36995.3 37096.3 37243.6 37271.0 7627.9 7754.5 7832.2 7839.5 7874.9 7692.6 7816.0 7816.1 7956.7 7988.4 7915.9 7998.9 8021.8 8022.1 8029.3 7802.9 7882.8 7885.4 7886.9 7911.5 7873.4 7934.7 7969.7 7970.4 7981.0 36923.4 37282.0 37427.1 37433.0 37457.6 3153.3 3234.2 3249.4 3277.7 3302.3 28173.3 28595.9 28749.4 28996.3 29108.6 3457.6 3550.3 3590.9 3593.8 3604.2 228064.0 229437.0 230536.0 231280.0 231537.0 33653.0 50348.5 50548.0 50653.5 50790.0 33054.7 33079.5 33159.5 33253.2 33255.5 12846.9 12926.9 12972.2 12995.6 13103.9 10689.8 10710.5 10713.0 10758.6 10765.3 8071.1 8074.3 8171.1 8189.9 8204.5 3219.7 3220.8 3268.2 3271.3 3282.3 956.2 997.5 1007.9 1027.2 1057.7 28401.0 28903.4 29345.9 29505.9 31056.8 899.1 958.4 967.3 981.8 995.3 13622.7 14038.7 14159.2 14217.6 14445.7 324923.0 330113.0 330786.0 331685.0 332413.0 46452.0 47119.8 47221.8 47524.3 47575.8 1206.6 1228.7 1230.0 1239.6 1263.1 25491.4 26719.0 26834.7 26993.9 27128.0 40767.6 41456.8 41653.6 41697.0 41801.8 235339.0 236326.0 238259.0 317606.0 319007.0 24864.9 25196.6 25209.9 25246.1 25262.2 40158.4 40698.0 40837.8 41458.6 41807.8 34040.8 35292.3 35736.8 36324.5 36451.6 34049.7 34716.3 34869.8 34882.0 35353.5 35126.5 35218.1 35888.8 37415.6 37538.4 27205.4 30911.0 31073.4 31089.2 31227.8 22730.0 24079.6 24232.0 24545.0 24707.9 06:50:00 INFO - PROCESS | 32153 | 06:50:00 INFO - PROCESS | 32153 | [#2] jquery.html Cycles:180 Average:23186.23 Median:4012.09 stddev:61342.26 (1528.9%) stddev-sans-first:61490.41 06:50:00 INFO - PROCESS | 32153 | Values: 368.6 372.9 374.0 375.0 386.9 15226.6 15563.4 16282.0 16345.3 16388.6 15610.0 16009.5 16284.8 16404.1 16419.4 4872.2 5093.5 5129.1 5137.9 5150.7 4980.9 5046.6 5060.9 5077.3 5085.4 4931.4 5222.1 5238.1 5247.8 5253.4 5053.6 5169.2 5217.7 5345.2 5363.3 5188.1 5193.6 5198.0 5211.5 5231.6 11763.6 11917.5 12516.9 12524.7 12550.4 1778.4 1870.9 2034.3 2152.9 2181.6 9378.3 10171.5 10293.1 11802.2 12520.5 1692.3 1761.6 1836.1 1864.3 1910.3 65168.3 67645.0 67902.0 68287.3 70382.3 8995.6 9096.2 9336.0 9361.1 9530.0 12626.6 12627.2 12634.5 12659.9 12704.9 6797.8 6995.6 7039.4 7104.3 7117.1 6478.5 6584.1 6605.9 6682.6 6825.5 3935.1 3971.7 4052.5 4052.5 4054.2 1867.7 1888.4 1901.9 1914.2 1921.1 822.2 889.0 933.7 933.8 1006.1 15471.0 15929.2 16080.8 16383.9 16450.8 864.9 882.7 915.3 922.7 953.5 8795.5 8925.6 9012.6 9163.5 9181.3 336680.0 370329.0 374657.0 380143.0 391011.0 69232.3 74440.0 76563.0 77053.6 78420.0 968.7 986.1 1002.8 1016.5 1017.9 14961.5 14969.6 15241.9 15284.6 15734.7 33945.2 34050.8 34297.0 34683.7 34720.3 48907.8 49071.0 49463.3 49605.3 49778.0 7463.3 7629.4 7643.8 7688.9 7778.2 10958.4 11258.6 11432.7 11799.7 11821.2 6213.8 10451.3 10507.2 10585.6 10815.7 10137.7 10181.4 10645.5 10782.9 10831.3 9828.8 10154.3 10349.0 10558.3 11200.8 7797.0 7854.1 7886.4 7924.3 8008.6 8083.6 9756.2 10651.9 10758.7 10951.2 06:50:00 INFO - PROCESS | 32153 | 06:50:00 INFO - PROCESS | 32153 | [#3] mootools.html Cycles:180 Average:5149.50 Median:5135.03 stddev:2831.48 (55.1%) stddev-sans-first:2825.86 06:50:00 INFO - PROCESS | 32153 | Values: 1461.1 1461.8 1608.0 1680.5 1749.1 6727.5 7601.6 7612.0 7842.0 7846.8 7628.9 7648.0 7666.2 7690.8 7807.3 2248.1 2255.7 2268.7 2269.0 2283.2 2109.7 2111.3 2113.9 2145.1 2226.2 2208.6 2224.7 2238.7 2262.5 2293.5 2237.5 2252.7 2258.1 2258.5 2267.1 2037.7 2040.3 2043.4 2058.5 2060.1 7840.4 7886.8 7896.2 7908.6 7941.2 4494.2 4629.1 4632.8 4660.6 4694.0 3022.7 3026.3 3141.8 3142.9 3149.2 953.3 957.6 960.0 978.0 1007.6 10495.6 10637.7 10678.4 10686.2 10733.5 4166.9 4175.6 4333.9 4362.6 4398.7 9191.2 9204.0 9207.3 9211.4 9255.9 4677.8 4692.5 4701.0 4713.3 4716.0 3700.6 4124.7 4225.4 4264.3 4284.6 3609.7 3633.3 3662.1 3753.9 3800.7 1165.0 1166.7 1178.7 1180.7 1201.3 818.8 834.9 884.9 890.3 896.6 5390.9 5423.2 5434.6 5535.8 5645.2 419.9 425.3 430.2 432.6 433.4 3801.9 3868.3 3922.0 3944.2 3971.6 9263.7 9451.8 9473.2 9548.4 9568.0 8806.2 9077.9 9141.7 9524.4 9563.3 7149.8 7217.9 7236.8 7260.5 7268.1 5426.8 5663.3 5754.7 5761.9 5776.4 8670.8 8696.5 8793.3 8797.2 8873.4 8346.7 8708.7 8740.6 8797.9 8932.9 6235.6 6571.0 6634.7 6768.7 6999.3 7269.1 7303.3 7314.2 7348.7 7428.4 6527.6 6776.4 6795.7 6802.0 6897.6 6565.3 6597.4 6659.4 6714.0 6720.2 6459.8 6476.8 6541.2 6558.3 6565.3 4623.1 4673.6 4732.5 4817.8 4819.9 4753.6 4803.7 4820.1 4840.7 4879.2 06:50:00 INFO - PROCESS | 32153 | 06:50:00 INFO - PROCESS | 32153 | [#4] prototype.html Cycles:180 Average:4654.89 Median:5322.33 stddev:1381.94 (26.0%) stddev-sans-first:1346.58 06:50:00 INFO - PROCESS | 32153 | Values: 298.2 302.6 312.1 312.7 314.7 5081.2 5222.9 5298.5 5403.5 5417.2 5310.2 5333.1 5334.3 5339.3 5393.0 4090.1 4142.4 4158.1 4163.4 4177.5 4156.8 4159.2 4177.0 4198.7 4200.1 3841.4 4075.6 4079.1 4091.1 4109.5 4045.3 4053.8 4069.0 4088.9 4089.8 3399.3 3553.5 3556.2 3562.4 3566.4 5159.5 5164.9 5166.8 5168.4 5171.7 4664.6 4681.2 4688.9 4696.8 4726.2 5345.9 5628.5 5650.6 5657.0 5657.7 3874.2 3876.8 3885.4 3885.8 3893.2 5591.7 5791.8 5893.2 5948.7 5970.6 3999.5 4003.4 4003.5 4019.6 4024.9 4040.3 4041.0 4054.3 4066.0 4072.0 4593.7 4677.1 4688.9 4694.4 4697.6 5620.9 5641.8 5657.3 5675.1 5685.3 1389.5 1406.2 1413.2 1413.5 1423.9 903.8 935.7 944.8 947.8 948.8 5015.2 5018.3 5025.5 5030.7 5036.1 5860.3 5861.4 5868.6 5873.6 5879.6 4903.0 4987.0 4992.9 5020.1 5021.2 3120.7 3127.8 3132.5 3140.5 3146.7 5492.4 5508.2 5520.6 5521.2 5547.7 5792.5 5975.9 5998.1 6032.8 6036.1 5442.9 5491.9 5530.4 5536.6 5552.8 5541.5 5821.5 5822.4 5834.2 5839.3 5716.8 5734.3 5736.4 5745.8 5770.7 5225.1 5311.6 5491.6 5516.8 5556.3 3924.2 3944.6 3951.3 3953.5 3956.6 5791.6 5851.5 5853.7 5856.2 5867.0 5453.8 5618.4 5658.2 5662.6 5716.2 5593.7 5615.7 5625.5 5650.0 5654.1 5392.4 5550.2 5552.3 5568.3 5572.3 5675.8 5679.3 5693.9 5714.2 5715.7 5532.5 5551.3 5565.5 5603.0 5605.9 06:50:00 INFO - PROCESS | 32153 | 06:50:00 INFO - PROCESS | 32153 | [#5] yui.html Cycles:180 Average:12502.08 Median:47749.90 stddev:14249.68 (29.8%) stddev-sans-first:14262.17 06:50:00 INFO - PROCESS | 32153 | Values: 717.2 731.3 733.6 769.4 798.4 11572.9 11597.0 11697.9 11749.3 11949.0 12057.9 12076.9 12093.4 12149.6 12158.9 786.9 815.8 820.9 826.1 827.5 822.1 823.8 830.8 830.9 831.1 850.5 861.1 861.3 862.2 862.7 845.6 847.8 853.9 856.9 858.7 620.2 623.5 624.2 627.1 630.3 11678.3 11718.9 11723.3 11736.4 11761.9 11902.2 11962.3 12044.0 12119.5 12356.3 9350.3 9407.9 9627.0 11581.8 11856.1 3251.3 3294.4 3294.7 3295.7 3329.0 47232.5 47545.3 47578.5 47921.3 47928.0 9018.1 9067.8 9225.0 9235.1 9427.0 15393.5 15400.5 15491.8 15526.1 15589.5 6174.6 6365.0 6403.6 6442.1 6492.2 3635.4 3653.4 3704.6 3756.2 3770.8 2861.3 2921.4 2925.8 2926.0 2929.2 484.2 488.3 493.5 493.9 494.4 565.6 595.4 603.1 659.7 672.6 7594.8 7692.0 7734.8 7761.4 7890.1 506.7 528.1 572.7 588.5 650.5 3574.1 3709.6 3744.5 3755.8 3831.0 50066.2 51431.5 51632.0 51864.5 52716.7 46159.3 46397.0 46955.8 47270.8 47403.3 39861.4 40083.2 41657.8 41853.0 43007.1 7277.3 7316.9 7477.4 7505.7 7593.7 27584.4 27628.4 28098.7 28288.2 28365.0 34087.1 34739.8 36029.3 36536.8 36597.8 9659.0 9681.5 9692.3 9915.9 10123.1 10892.9 11179.8 11396.1 11586.5 11964.5 10978.3 11618.7 11738.6 12188.3 12254.4 11266.7 11336.3 11488.6 11520.2 11883.5 11255.9 11555.0 11559.5 11590.7 11722.8 9328.9 9491.1 9551.6 9688.2 9912.6 8931.0 9319.8 9357.0 9446.1 9540.0 06:50:00 INFO - PROCESS | 32153 | -------- Summary: end -------- 06:50:00 INFO - PROCESS | 32153 | 06:50:01 INFO - TEST-INFO | 32153: exit 0 06:50:01 INFO - TEST-OK | dromaeo_css | took 1115398ms 06:50:01 INFO - TEST-START | kraken 06:50:01 INFO - operating with platform_type : linux_ 06:50:01 INFO - Initialising browser for kraken test... 06:50:01 INFO - TEST-INFO | started process 32390 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvBRYTg/profile http://localhost:45620/getInfo.html) 06:50:05 INFO - PROCESS | 32390 | 06:50:05 INFO - PROCESS | 32390 | (process:32458): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:50:06 INFO - PROCESS | 32390 | __metrics Screen width/height:1600/1200 06:50:06 INFO - PROCESS | 32390 | colorDepth:24 06:50:06 INFO - PROCESS | 32390 | Browser inner width/height: 1024/697 06:50:06 INFO - PROCESS | 32390 | __metrics 06:50:07 ERROR - PROCESS | 32390 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:50:08 INFO - TEST-INFO | 32390: exit 0 06:50:08 INFO - Browser initialized. 06:50:08 INFO - Running cycle 1/1 for kraken test... 06:50:08 INFO - TEST-INFO | started process 32510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvBRYTg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:50:10 INFO - PROCESS | 32510 | 06:50:10 INFO - PROCESS | 32510 | (process:32571): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:50:20 INFO - PROCESS | 32510 | RSS: Main: 164130816 06:50:20 INFO - PROCESS | 32510 | 06:50:22 INFO - PROCESS | 32510 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45620/tests/kraken/driver.html?testName=audio-beat-detection) 06:50:23 INFO - PROCESS | 32510 | RSS: Main: 168013824 06:50:23 INFO - PROCESS | 32510 | 06:50:26 INFO - PROCESS | 32510 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45620/tests/kraken/driver.html?testName=audio-dft) 06:50:27 INFO - PROCESS | 32510 | RSS: Main: 171503616 06:50:27 INFO - PROCESS | 32510 | 06:50:30 INFO - PROCESS | 32510 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45620/tests/kraken/driver.html?testName=audio-fft) 06:50:30 INFO - PROCESS | 32510 | RSS: Main: 165511168 06:50:30 INFO - PROCESS | 32510 | 06:50:32 INFO - PROCESS | 32510 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45620/tests/kraken/driver.html?testName=audio-oscillator) 06:50:33 INFO - PROCESS | 32510 | RSS: Main: 165519360 06:50:33 INFO - PROCESS | 32510 | 06:50:35 INFO - PROCESS | 32510 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45620/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:50:36 INFO - PROCESS | 32510 | RSS: Main: 166055936 06:50:36 INFO - PROCESS | 32510 | 06:50:39 INFO - PROCESS | 32510 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45620/tests/kraken/driver.html?testName=imaging-darkroom) 06:50:40 INFO - PROCESS | 32510 | RSS: Main: 165826560 06:50:40 INFO - PROCESS | 32510 | 06:50:43 INFO - PROCESS | 32510 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45620/tests/kraken/driver.html?testName=imaging-desaturate) 06:50:44 INFO - PROCESS | 32510 | RSS: Main: 163377152 06:50:44 INFO - PROCESS | 32510 | 06:50:47 INFO - PROCESS | 32510 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45620/tests/kraken/driver.html?testName=json-parse-financial) 06:50:47 INFO - PROCESS | 32510 | RSS: Main: 164044800 06:50:47 INFO - PROCESS | 32510 | 06:50:49 INFO - PROCESS | 32510 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45620/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:50:50 INFO - PROCESS | 32510 | RSS: Main: 164773888 06:50:50 INFO - PROCESS | 32510 | 06:50:52 INFO - PROCESS | 32510 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45620/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:50:52 INFO - PROCESS | 32510 | RSS: Main: 165339136 06:50:52 INFO - PROCESS | 32510 | 06:50:55 INFO - PROCESS | 32510 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45620/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:50:55 INFO - PROCESS | 32510 | RSS: Main: 164888576 06:50:55 INFO - PROCESS | 32510 | 06:50:58 INFO - PROCESS | 32510 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:50:59 INFO - PROCESS | 32510 | RSS: Main: 165117952 06:50:59 INFO - PROCESS | 32510 | 06:51:02 INFO - PROCESS | 32510 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:51:02 INFO - PROCESS | 32510 | RSS: Main: 165277696 06:51:02 INFO - PROCESS | 32510 | 06:51:04 INFO - PROCESS | 32510 | Cycle 1(1): loaded http://localhost:45620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45620/tests/kraken/driver.html?testName=ai-astar) 06:51:05 INFO - PROCESS | 32510 | RSS: Main: 166793216 06:51:05 INFO - PROCESS | 32510 | 06:51:05 INFO - PROCESS | 32510 | __start_tp_report 06:51:05 INFO - PROCESS | 32510 | _x_x_mozilla_page_load 06:51:05 INFO - PROCESS | 32510 | _x_x_mozilla_page_load_details 06:51:05 INFO - PROCESS | 32510 | |i|pagename|runs| 06:51:05 INFO - PROCESS | 32510 | |0;ai-astar;114;107;116;116;115;125;114;116;115;120 06:51:05 INFO - PROCESS | 32510 | |1;audio-beat-detection;160;144;160;198;131;176;157;137;183;133 06:51:05 INFO - PROCESS | 32510 | |2;audio-dft;163;163;165;170;163;161;161;163;165;163 06:51:05 INFO - PROCESS | 32510 | |3;audio-fft;75;75;77;160;75;77;79;78;154;75 06:51:05 INFO - PROCESS | 32510 | |4;audio-oscillator;94;95;140;95;95;93;148;96;95;144 06:51:05 INFO - PROCESS | 32510 | |5;imaging-gaussian-blur;119;117;118;117;118;117;118;118;118;117 06:51:05 INFO - PROCESS | 32510 | |6;imaging-darkroom;148;148;147;148;147;147;148;147;149;147 06:51:05 INFO - PROCESS | 32510 | |7;imaging-desaturate;95;97;95;95;95;95;95;96;96;96 06:51:05 INFO - PROCESS | 32510 | |8;json-parse-financial;66;66;78;65;67;67;67;89;64;70 06:51:05 INFO - PROCESS | 32510 | |9;json-stringify-tinderbox;65;65;65;65;64;69;65;69;65;65 06:51:05 INFO - PROCESS | 32510 | |10;stanford-crypto-aes;87;81;80;81;96;82;89;90;82;81 06:51:05 INFO - PROCESS | 32510 | |11;stanford-crypto-ccm;137;136;141;156;134;148;146;136;222;150 06:51:05 INFO - PROCESS | 32510 | |12;stanford-crypto-pbkdf2;186;178;183;181;182;180;180;178;181;179 06:51:05 INFO - PROCESS | 32510 | |13;stanford-crypto-sha256-iterative;75;76;77;76;77;72;73;72;76;80 06:51:05 INFO - PROCESS | 32510 | __end_tp_report 06:51:05 INFO - PROCESS | 32510 | __start_cc_report 06:51:05 INFO - PROCESS | 32510 | _x_x_mozilla_cycle_collect,905 06:51:05 INFO - PROCESS | 32510 | __end_cc_report 06:51:05 INFO - PROCESS | 32510 | __startTimestamp1461246665060__endTimestamp 06:51:05 INFO - PROCESS | 32510 | 06:51:05 INFO - PROCESS | 32510 | ------- Summary: start ------- 06:51:05 INFO - PROCESS | 32510 | Number of tests: 14 06:51:05 INFO - PROCESS | 32510 | 06:51:05 INFO - PROCESS | 32510 | [#0] ai-astar Cycles:10 Average:115.80 Median:116.00 stddev:4.57 (3.9%) stddev-sans-first:4.80 06:51:05 INFO - PROCESS | 32510 | Values: 114.0 107.0 116.0 116.0 115.0 125.0 114.0 116.0 115.0 120.0 06:51:05 INFO - PROCESS | 32510 | 06:51:05 INFO - PROCESS | 32510 | [#1] audio-beat-detection Cycles:10 Average:157.90 Median:160.00 stddev:22.48 (14.1%) stddev-sans-first:23.83 06:51:05 INFO - PROCESS | 32510 | Values: 160.0 144.0 160.0 198.0 131.0 176.0 157.0 137.0 183.0 133.0 06:51:05 INFO - PROCESS | 32510 | 06:51:05 INFO - PROCESS | 32510 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:2.58 (1.6%) stddev-sans-first:2.73 06:51:05 INFO - PROCESS | 32510 | Values: 163.0 163.0 165.0 170.0 163.0 161.0 161.0 163.0 165.0 163.0 06:51:05 INFO - PROCESS | 32510 | 06:51:05 INFO - PROCESS | 32510 | [#3] audio-fft Cycles:10 Average:92.50 Median:76.00 stddev:34.05 (44.8%) stddev-sans-first:35.53 06:51:05 INFO - PROCESS | 32510 | Values: 75.0 75.0 77.0 160.0 75.0 77.0 79.0 78.0 154.0 75.0 06:51:05 INFO - PROCESS | 32510 | 06:51:05 INFO - PROCESS | 32510 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:95.00 stddev:23.89 (25.2%) stddev-sans-first:24.68 06:51:05 INFO - PROCESS | 32510 | Values: 94.0 95.0 140.0 95.0 95.0 93.0 148.0 96.0 95.0 144.0 06:51:05 INFO - PROCESS | 32510 | 06:51:05 INFO - PROCESS | 32510 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 06:51:05 INFO - PROCESS | 32510 | Values: 119.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 117.0 06:51:05 INFO - PROCESS | 32510 | 06:51:05 INFO - PROCESS | 32510 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 06:51:05 INFO - PROCESS | 32510 | Values: 148.0 148.0 147.0 148.0 147.0 147.0 148.0 147.0 149.0 147.0 06:51:05 INFO - PROCESS | 32510 | 06:51:05 INFO - PROCESS | 32510 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 06:51:05 INFO - PROCESS | 32510 | Values: 95.0 97.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 06:51:05 INFO - PROCESS | 32510 | 06:51:05 INFO - PROCESS | 32510 | [#8] json-parse-financial Cycles:10 Average:69.90 Median:67.00 stddev:7.78 (11.6%) stddev-sans-first:8.12 06:51:05 INFO - PROCESS | 32510 | Values: 66.0 66.0 78.0 65.0 67.0 67.0 67.0 89.0 64.0 70.0 06:51:05 INFO - PROCESS | 32510 | 06:51:05 INFO - PROCESS | 32510 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:65.00 stddev:1.77 (2.7%) stddev-sans-first:1.86 06:51:05 INFO - PROCESS | 32510 | Values: 65.0 65.0 65.0 65.0 64.0 69.0 65.0 69.0 65.0 65.0 06:51:05 INFO - PROCESS | 32510 | 06:51:05 INFO - PROCESS | 32510 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.50 stddev:5.34 (6.3%) stddev-sans-first:5.61 06:51:05 INFO - PROCESS | 32510 | Values: 87.0 81.0 80.0 81.0 96.0 82.0 89.0 90.0 82.0 81.0 06:51:05 INFO - PROCESS | 32510 | 06:51:05 INFO - PROCESS | 32510 | [#11] stanford-crypto-ccm Cycles:10 Average:150.60 Median:147.00 stddev:26.11 (17.8%) stddev-sans-first:27.22 06:51:05 INFO - PROCESS | 32510 | Values: 137.0 136.0 141.0 156.0 134.0 148.0 146.0 136.0 222.0 150.0 06:51:05 INFO - PROCESS | 32510 | 06:51:05 INFO - PROCESS | 32510 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.80 Median:181.00 stddev:2.44 (1.3%) stddev-sans-first:1.72 06:51:05 INFO - PROCESS | 32510 | Values: 186.0 178.0 183.0 181.0 182.0 180.0 180.0 178.0 181.0 179.0 06:51:05 INFO - PROCESS | 32510 | 06:51:05 INFO - PROCESS | 32510 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.40 Median:76.00 stddev:2.50 (3.3%) stddev-sans-first:2.65 06:51:05 INFO - PROCESS | 32510 | Values: 75.0 76.0 77.0 76.0 77.0 72.0 73.0 72.0 76.0 80.0 06:51:05 INFO - PROCESS | 32510 | -------- Summary: end -------- 06:51:05 INFO - PROCESS | 32510 | 06:51:06 INFO - TEST-INFO | 32510: exit 0 06:51:06 INFO - TEST-OK | kraken | took 64576ms 06:51:06 INFO - SUITE-END | took 1179s 06:51:06 INFO - Completed test suite (00:19:40) 06:51:06 INFO - javascript benchmark 06:51:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2579.690437147542, 2634.723354047824, 2655.296346468185, 2666.173486219271, 2680.0753739959705, 4779.091972525218, 4787.28190771384, 4796.880077998052, 4839.101607248243, 4868.878278043051, 4648.558386953243, 4675.906481870361, 4765.618750499961, 4832.251001094827, 4845.7819398127085, 4342.826286948526, 4367.58507941745, 4433.2241857674935, 4437.267850804614, 4471.441069866267, 4366.759828209447, 4446.355278484618, 4511.390962220091, 4513.232750432418, 4536.637069034469, 4320.870373888788, 4360.411344468488, 4400.427944367244, 4446.133004064192, 4456.286994080931, 4371.4972778130605, 4374.562543745632, 4386.583274588909, 4403.383526306319, 4436.977815110904, 4350.825966961318, 4351.608355248043, 4366.759828209447, 4405.140997505488, 4408.691391602589, 4479.4176757021705, 4616.6537509686905, 4661.09108723799, 4668.603168730662, 4685.648576356787, 5094.1825631414295, 5118.07874582575, 5154.020736060136, 5156.484351564814, 5190.247414124969, 4977.626677999128, 5166.974165129188, 5172.250023746573, 5172.948270517322, 5173.689578625257, 4697.859064228079, 4710.811567537328, 4718.197906355927, 4748.548887855648, 4756.833510827174, 5192.428832828386, 5209.348831396075, 5210.062188805976, 5228.05894938907, 5268.28878101459, 4997.350344455198, 4999.575036121898, 5002.199648056294, 5003.399592048904, 5085.771140298695, 5057.115004874206, 5061.974690126526, 5072.594192464594, 5073.644844860824, 5128.692278463304, 4878.609711223094, 4961.528654777862, 5017.8243761468175, 5027.296178534935, 5057.544820966131, 4854.927176092361, 4992.90014199714, 5005.774740136702, 5053.140966035783, 5135.281060651511, 4210.073783767566, 4215.304474761691, 4223.345381465878, 4254.532001479834, 4261.573842615714, 3728.9813550932613, 3735.533058367704, 3755.6432138946757, 3768.491253680718, 3776.716746243988, 4302.139572085595, 4413.404190434315, 4484.551544845554, 4494.595486406239, 4498.190325741398, 4999.725015124203, 5007.749612519359, 5030.119729047402, 5045.990801839646, 5053.418856831511, 4404.273294906305, 4410.250257456176, 4410.845620403271, 4412.0734645724115, 4455.844045458393, 4451.287793953017, 4536.8638940831825, 4588.311753236974, 4601.28680054592, 4627.652926030494, 4772.904541909073, 4777.402824646919, 4794.544518270759, 4800.303955926371, 4803.711777293373, 4882.90234195307, 5042.798288068436, 5050.267711181785, 5056.443791182894, 5099.5410413063, 4818.7831547581145, 4871.855114048125, 4891.706497610155, 4894.608431325414, 4930.852074437773, 5057.494250574913, 5091.032703786417, 5091.465396133352, 5097.0315640028275, 5142.460041695717, 4933.33399991011, 5078.339815823919, 5159.871003224949, 5165.405978312392, 5169.095408303607, 4835.975820120877, 4905.583025442877, 4988.501149884983, 5002.52476014778, 5009.949900500948, 4951.480094590161, 4970.478099799614, 4974.825881094144, 4979.551840334242, 5008.2738002988635, 4641.605463535638, 4887.0, 4897.510248975074, 4899.559039686445, 4901.1913034350355, 5005.62457815658, 5012.348394708664, 5023.447420783784, 5031.471695471922, 5076.847694569169, 4814.8796280093275, 4856.927146092882, 4865.95134048655, 4866.440359358578, 4880.877978050577], "value": 4671.001628120641, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.5783488878674, 559.5048382181769, 576.3228206856942, 601.6330038676404, 611.571899670231, 33250.501242481354, 34312.31375372494, 34326.65673343266, 34351.14122146948, 34464.48303275447, 36317.63682363176, 36995.260094798155, 37096.258074838486, 37243.62756372435, 37271.0, 7627.923720762805, 7754.534727916315, 7832.1776213497615, 7839.529628222325, 7874.881876771853, 7692.615369231544, 7816.0, 7816.062072551302, 7956.721514746985, 7988.4408091433625, 7915.881261781078, 7998.920010799905, 8021.839563208732, 8022.077461091962, 8029.2773650371455, 7802.921970780305, 7882.842343153134, 7885.408594355417, 7886.881696774553, 7911.485753426066, 7873.409494287951, 7934.682612695486, 7969.721059762938, 7970.402219833536, 7981.0, 36923.4461483078, 37282.0, 37427.06432339186, 37433.0, 37457.62542374569, 3153.274746808224, 3234.207619133304, 3249.366373557157, 3277.655846136169, 3302.290007648343, 28173.29566760827, 28595.85702071497, 28749.42501149986, 28996.27509312263, 29108.563371549233, 3457.5539496784686, 3550.3254381667402, 3590.935212252939, 3593.82030898454, 3604.1710406606367, 228064.0, 229437.0, 230536.0, 231280.0, 231537.0, 33653.0, 50348.49651503511, 50547.98904021899, 50653.480395588194, 50790.0, 33054.669453305156, 33079.50380744291, 33159.502607460905, 33253.16867078294, 33255.50116748251, 12846.871531284754, 12926.870731292754, 12972.221666700028, 12995.610131696065, 13103.868961310456, 10689.786204275872, 10710.46447677613, 10713.035826775627, 10758.569657213624, 10765.300255483526, 8071.112177660452, 8074.313683336982, 8171.10117887032, 8189.918100819034, 8204.466709663971, 3219.6780321968085, 3220.838958052088, 3268.2156282492506, 3271.329377477611, 3282.343531293751, 956.1633570625703, 997.491279447487, 1007.9064215326453, 1027.1577306608658, 1057.735566108473, 28401.0, 28903.421931561672, 29345.853270733936, 29505.90188030226, 31056.844715776275, 899.1098812175899, 958.3579002068631, 967.274544091931, 981.8183636027215, 995.3331268050424, 13622.727545449035, 14038.71922561543, 14159.221242831743, 14217.64455888611, 14445.711085778226, 324923.0, 330113.0, 330786.0, 331685.0, 332413.0, 46452.0, 47119.764401177774, 47221.76389118032, 47524.28713569299, 47575.762121189175, 1206.6440400081997, 1228.7112528555783, 1229.9938500307442, 1239.60332693539, 1263.134752694389, 25491.36271593225, 26719.0, 26834.731652683222, 26993.865030674722, 27128.0, 40767.59232407757, 41456.79271603622, 41653.58346416497, 41697.0, 41801.79099104485, 235339.0, 236326.0, 238259.0, 317606.0, 319007.0, 24864.875675621504, 25196.622050668888, 25209.873950630128, 25246.116385926405, 25262.242132736046, 40158.397624036246, 40698.0, 40837.795811020755, 41458.58541414547, 41807.790961045, 34040.82979585086, 35292.294154117284, 35736.821315893256, 36324.45513317355, 36451.63548364482, 34049.65950340564, 34716.30567388688, 34869.825650871586, 34882.0, 35353.46969795404, 35126.473102902964, 35218.11954701153, 35888.82055589705, 37415.6258437423, 37538.436923446716, 27205.373113505648, 30911.0, 31073.37853242877, 31089.222769430944, 31227.84386078055, 22730.02331233596, 24079.638805418283, 24232.0, 24545.018199271828, 24707.876460617583], "value": 16109.825026867858, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.60559201654223, 372.9272791805597, 373.96447337502934, 374.99437508437376, 386.9226154769047, 15226.619334516628, 15563.377464901405, 16282.0, 16345.34618615254, 16388.590285242874, 15610.0, 16009.519714408558, 16284.83715162848, 16404.09777462239, 16419.425320113798, 4872.220444728853, 5093.541581257705, 5129.0767661820855, 5137.871553211162, 5150.690958542481, 4980.87547811304, 5046.571041461461, 5060.924086138711, 5077.263796749469, 5085.440601533847, 4931.358923339961, 5222.138347172712, 5238.109521381355, 5247.842564723045, 5253.369595648527, 5053.64624476285, 5169.172932330828, 5217.739113044351, 5345.1714984177515, 5363.275957745694, 5188.066148093341, 5193.584513238932, 5198.038362902875, 5211.478852114796, 5231.555317797992, 11763.588274410355, 11917.463714132798, 12516.937415312865, 12524.74950500994, 12550.435230414654, 1778.4042345814169, 1870.9158087885942, 2034.3083351660507, 2152.924647637341, 2181.596404665126, 9378.296627752945, 10171.542280597318, 10293.073623373932, 11802.232854864405, 12520.499180032788, 1692.3061544766585, 1761.594833188361, 1836.0636075601406, 1864.3102052240622, 1910.2645481489587, 65168.348316516705, 67645.0, 67901.98147027798, 68287.3171268286, 70382.2961770386, 8995.640174392951, 9096.181343678969, 9335.953320233355, 9361.110694484014, 9529.952350238205, 12626.558070467674, 12627.179233349803, 12634.494620215271, 12659.936700316439, 12704.936475317565, 6797.762078327334, 6995.580265184105, 7039.401650859631, 7104.25405332443, 7117.074780278531, 6478.5141114415665, 6584.078229047937, 6605.933940660628, 6682.63245521501, 6825.522213445011, 3935.0752573145287, 3971.7219794614675, 4052.452918855976, 4052.5339585947404, 4054.2499637567144, 1867.738516607676, 1888.3862744608057, 1901.9334323298895, 1914.2343062775, 1921.0586812461793, 822.198356602308, 888.9822203555892, 933.6918816790443, 933.8365785987424, 1006.1095930101766, 15470.998746134766, 15929.203539823195, 16080.758788618181, 16383.918080409521, 16450.75323870143, 864.883240762489, 882.7440042387764, 915.2769312243387, 922.7231830450838, 953.5422996961497, 8795.47227166372, 8925.553722313858, 9012.594433250519, 9163.49600771964, 9181.265498760084, 336680.0, 370329.0, 374657.0, 380143.0, 391011.0, 69232.30767692359, 74440.0, 76563.0, 77053.6147319271, 78420.0, 968.6900191938512, 986.1174249047062, 1002.7693630465034, 1016.5019140621042, 1017.8982101789762, 14961.476348327757, 14969.550913472613, 15241.923790380977, 15284.617884552976, 15734.685306294039, 33945.151371215914, 34050.829745851115, 34297.0, 34683.65316346804, 34720.305593888486, 48907.75546122246, 49071.0, 49463.25805112854, 49605.25592116049, 49778.0, 7463.328300452985, 7629.427792915442, 7643.770686879402, 7688.884666729891, 7778.222177782177, 10958.39728814891, 11258.59267591551, 11432.657020289405, 11799.705007374885, 11821.172517923662, 6213.782517611862, 10451.32066415711, 10507.211959102944, 10585.629502967358, 10815.729606759895, 10137.695869123938, 10181.389116653025, 10645.467726613793, 10782.946085269523, 10831.2959657622, 9828.803423931624, 10154.289199755945, 10349.0, 10558.260921735406, 11200.775984480102, 7796.961015194887, 7854.1360450349275, 7886.44794864354, 7924.326432253323, 8008.599570021592, 8083.555404452576, 9756.219502439646, 10651.946740266249, 10758.731031723957, 10951.178661600572], "value": 7986.744577057133, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1461.050317293759, 1461.7734251191066, 1607.9598010049747, 1680.4622520793337, 1749.1166960684852, 6727.529072964894, 7601.58191299479, 7612.0, 7841.960790196048, 7846.843063138734, 7628.923710762891, 7648.043994500687, 7666.233376662345, 7690.807729806757, 7807.297343239107, 2248.05581655705, 2255.6842042114117, 2268.671042698816, 2268.965965510519, 2283.200879692111, 2109.725735654363, 2111.2610586294827, 2113.8625989310644, 2145.131221855151, 2226.2430773536994, 2208.6024515587187, 2224.699665545155, 2238.664200369941, 2262.4570103175283, 2293.5183611441616, 2237.4853783629856, 2252.7296724393013, 2258.06290389489, 2258.54829034193, 2267.104493724986, 2037.6943458481198, 2040.3470889315424, 2043.4176259766043, 2058.547119633693, 2060.1450398084776, 7840.372770178372, 7886.842263154762, 7896.210378962115, 7908.565028923407, 7941.245581669732, 4494.235979883428, 4629.120467111238, 4632.791524381377, 4660.557247061523, 4694.037722266927, 3022.7128422799797, 3026.3039500914692, 3141.8429078545983, 3142.921426964321, 3149.2126968257935, 953.3279038277998, 957.5595226195958, 959.9664011759625, 977.9804403911882, 1007.6070332570304, 10495.632652857113, 10637.73405664857, 10678.359298442118, 10686.19853510982, 10733.463326833706, 4166.854160104382, 4175.624193822509, 4333.891652708708, 4362.607365337135, 4398.670099742532, 9191.218746406497, 9203.953980230055, 9207.26341892647, 9211.355205135576, 9255.90744092564, 4677.789499472532, 4692.507286734844, 4700.95299047012, 4713.29300604912, 4715.95284047162, 3700.611435799256, 4124.731892427043, 4225.408442818008, 4264.33902745075, 4284.635805956528, 3609.729270304685, 3633.2733453309443, 3662.102784817737, 3753.9249215016093, 3800.6959443244473, 1164.9708757280966, 1166.6674997625805, 1178.7465694875643, 1180.698921774942, 1201.2732296960387, 818.8157664525553, 834.9271186525286, 884.8584226523855, 890.2521881619471, 896.6054935828215, 5390.865228369322, 5423.2136340230445, 5434.619576629677, 5535.778568857281, 5645.1532270159805, 419.9333692421277, 425.3407218810831, 430.249215119612, 432.595523185816, 433.3607928305787, 3801.9049523761573, 3868.3423817951016, 3922.0, 3944.171723938005, 3971.5631280559114, 9263.675771347971, 9451.76370590727, 9473.24214062887, 9548.427094374221, 9568.0, 8806.20744133031, 9077.863832042525, 9141.680041198659, 9524.428534287965, 9563.330566860392, 7149.82125446868, 7217.8917316240295, 7236.782896513113, 7260.528065675714, 7268.127824660969, 5426.8371948841595, 5663.348714897675, 5754.683492407958, 5761.942380576308, 5776.393478684678, 8670.78323041929, 8696.478211307342, 8793.252573531321, 8797.208251257418, 8873.423227490193, 8346.707865224687, 8708.738737837875, 8740.562971851508, 8797.912020879709, 8932.86600701003, 6235.594686345373, 6570.967145164243, 6634.734610615521, 6768.7292508299115, 6999.265077166824, 7269.091363579552, 7303.269673032654, 7314.232005639544, 7348.706051758084, 7428.405727541675, 6527.5757075789925, 6776.390124888783, 6795.660216989229, 6802.01370801241, 6897.55165914214, 6565.277819439762, 6597.373249541286, 6659.4006539411685, 6713.966430167818, 6720.1599800025, 6459.806205813833, 6476.805695829133, 6541.215054193337, 6558.278589355263, 6565.310642382481, 4623.12160689468, 4673.634194791285, 4732.455767586634, 4817.759112044454, 4819.879503012453, 4753.572178503951, 4803.687760295569, 4820.060088282751, 4840.685355451885, 4879.194932836184], "value": 4112.009998808518, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.1636509590599, 302.55071219239426, 312.0902569011332, 312.6576398843267, 314.6790273920601, 5081.187010078388, 5222.8694282642955, 5298.523132918037, 5403.540699040582, 5417.1603401472785, 5310.230016647593, 5333.093464062085, 5334.279872217249, 5339.332583427072, 5392.973035134829, 4090.0797320602924, 4142.425878166293, 4158.126793373395, 4163.354680024601, 4177.51958524769, 4156.8129434175535, 4159.188958153161, 4177.0, 4198.6850986176005, 4200.075983283673, 3841.4045822897497, 4075.572064933169, 4079.1433798902117, 4091.1204091120403, 4109.465769449967, 4045.3122969095325, 4053.817578208973, 4069.0, 4088.8773336799945, 4089.7546147230964, 3399.3031428557088, 3553.466979953028, 3556.1643013891717, 3562.3765840977726, 3566.4472006838982, 5159.535641792219, 5164.922526162073, 5166.844994650167, 5168.431472538018, 5171.715555644438, 4664.626829853638, 4681.157391669498, 4688.906221875577, 4696.7651617419, 4726.196546587088, 5345.8773657531965, 5628.465295796893, 5650.576206784508, 5656.981743286206, 5657.717114144276, 3874.2251549689895, 3876.8369489153424, 3885.3977633466575, 3885.825137868803, 3893.240818040483, 5591.700896471101, 5791.82624521265, 5893.204417403638, 5948.702564871739, 5970.641761494324, 3999.5200575930494, 4003.3794761811964, 4003.499562554681, 4019.5578486366476, 4024.879253622396, 4040.333344998101, 4040.9595904040584, 4054.3310353791294, 4066.0, 4072.0430698785763, 4593.747343896118, 4677.134730074947, 4688.882777930579, 4694.389729335233, 4697.6241900647865, 5620.903923734914, 5641.830745077655, 5657.2928383952, 5675.091985282335, 5685.260916080966, 1389.5483967710534, 1406.219548150786, 1413.2227274998709, 1413.4699487692114, 1423.9359228834728, 903.7605034665819, 935.6818681648136, 944.8393773058597, 947.772534591693, 948.8434408322687, 5015.247712843103, 5018.268697299426, 5025.522575355335, 5030.673006254582, 5036.093503169464, 5860.326062502867, 5861.3552509223955, 5868.559858010666, 5873.618214816023, 5879.617824841372, 4902.975485122552, 4987.027529631687, 4992.90014199714, 5020.146575082172, 5021.221710634857, 3120.6879312068613, 3127.8436078196, 3132.4988001919583, 3140.528920661919, 3146.7325277351224, 5492.423295553909, 5508.173773933861, 5520.613557051048, 5521.171824226398, 5547.667139971614, 5792.536597072309, 5975.940240597538, 5998.1105951625095, 6032.819015429544, 6036.124761909498, 5442.945570544323, 5491.862703432446, 5530.446955304518, 5536.584756143306, 5552.833414997556, 5541.528970037431, 5821.476067153976, 5822.388649191774, 5834.15404766315, 5839.299284085937, 5716.79991200306, 5734.254546909042, 5736.42635736423, 5745.770169193185, 5770.711464426846, 5225.1378522543355, 5311.575073994149, 5491.643043202179, 5516.751746171512, 5556.277683901067, 3924.156306394025, 3944.6449819516383, 3951.3085210087543, 3953.545342285559, 3956.6043395660204, 5791.623544469596, 5851.473367396955, 5853.707314634166, 5856.180134781219, 5867.002609556301, 5453.818472610988, 5618.438156184512, 5658.207850900795, 5662.603617746719, 5716.199732037601, 5593.664380137205, 5615.72563111924, 5625.521830644441, 5650.0, 5654.123610840326, 5392.379876314118, 5550.222968784293, 5552.250446189712, 5568.303962004749, 5572.331320241597, 5675.808080303017, 5679.346875109415, 5693.886122277614, 5714.200011998407, 5715.742791574472, 5532.5020748132865, 5551.306086739158, 5565.471280228372, 5603.0, 5605.859853503695], "value": 4208.052560432378, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.1501770402077, 731.3490993016214, 733.6478490324644, 769.3652736492395, 798.4011991006745, 11572.942135289322, 11597.0, 11697.941510292458, 11749.295042297468, 11949.044076473883, 12057.939710301436, 12076.879231207708, 12093.395330233498, 12149.635510934664, 12158.939205303983, 786.905571331441, 815.7634286057037, 820.9302209312216, 826.0912995704737, 827.4869580859876, 822.1244374740882, 823.7569916874536, 830.779843341515, 830.8546004449228, 831.0982583896449, 850.5194565070747, 861.1474640106281, 861.267922266072, 862.241227719609, 862.7411776467035, 845.6152450634946, 847.7922908887331, 853.871919212117, 856.8671855862289, 858.7466697324304, 620.218524658933, 623.5230049012509, 624.1916717850395, 627.1408170805979, 630.2625927664643, 11678.299302041905, 11718.941405293004, 11723.296602203895, 11736.35450050247, 11761.88238117625, 11902.166848320621, 11962.342071186082, 12044.0, 12119.454624541917, 12356.320402377865, 9350.298727595458, 9407.858882116774, 9627.0, 11581.768364632744, 11856.110791690659, 3251.3497300539752, 3294.3740689269202, 3294.67053294671, 3295.653956334574, 3328.9500657490157, 47232.527674723155, 47545.286820697715, 47578.5242147581, 47921.28118078197, 47928.0, 9018.143276388733, 9067.81864362709, 9225.0, 9235.07649235071, 9427.0, 15393.538193854203, 15400.460983865734, 15491.84508154904, 15526.1460619667, 15589.454369097028, 6174.629522228681, 6364.968175159094, 6403.58376705522, 6442.130312407765, 6492.156019717407, 3635.4365073413665, 3653.3606618841595, 3704.6480584344445, 3756.248750249906, 3770.792606406619, 2861.2846788302923, 2921.4303210873677, 2925.824450532975, 2925.956110658342, 2929.194471520349, 484.15756583545084, 488.3139189438844, 493.5114236905438, 493.8888750031286, 494.40671194566664, 565.5758181363977, 595.4075694683818, 603.1134232677956, 659.6800551732406, 672.6098862659645, 7594.772156835304, 7692.0, 7734.7679569613, 7761.379089672812, 7890.132085470594, 506.65294273422086, 528.1233152966058, 572.6856863498282, 588.5438784941618, 650.5316172355896, 3574.088607405147, 3709.647583479565, 3744.5319335083113, 3755.774653520743, 3830.961690383116, 50066.24900626494, 51431.485685143416, 51632.0, 51864.48135518596, 52716.736416317675, 46159.30761038587, 46397.0, 46955.76522117368, 47270.76364618155, 47403.28895066577, 39861.40207896884, 40083.198336033696, 41657.79171104125, 41853.0, 43007.13985720268, 7277.345038946521, 7316.890246646198, 7477.40180785525, 7505.6997720090585, 7593.696252149852, 27584.44831103407, 27628.447431050863, 28098.71901280961, 28288.15135545937, 28365.0, 34087.147821304665, 34739.826300868335, 36029.27941441104, 36536.81731591325, 36597.817010914776, 9659.0, 9681.515924203903, 9692.32153749259, 9915.900840991499, 10123.139533139765, 10892.891071089187, 11179.832302515631, 11396.08831293478, 11586.536538538365, 11964.46159922823, 10978.341299522055, 11618.6514404568, 11738.58914937973, 12188.268703877795, 12254.387280635754, 11266.718332041764, 11336.263142895685, 11488.55113298156, 11520.193586448868, 11883.524659013543, 11255.943720281346, 11555.0, 11559.537618495166, 11590.652280431601, 11722.824157637813, 9328.860067099135, 9491.145796878314, 9551.570179342085, 9688.224942004763, 9912.603495860374, 8931.0, 9319.767005824908, 9357.0, 9446.149846513847, 9539.952300238454], "value": 5855.9248603734795, "unit": "score"}], "name": "dromaeo_css", "value": 6272.4982863894365, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 116.0, 116.0, 115.0, 125.0, 114.0, 116.0, 115.0, 120.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 144.0, 160.0, 198.0, 131.0, 176.0, 157.0, 137.0, 183.0, 133.0], "value": 157.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 170.0, 163.0, 161.0, 161.0, 163.0, 165.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 160.0, 75.0, 77.0, 79.0, 78.0, 154.0, 75.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 140.0, 95.0, 95.0, 93.0, 148.0, 96.0, 95.0, 144.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 149.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 78.0, 65.0, 67.0, 67.0, 67.0, 89.0, 64.0, 70.0], "value": 69.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 69.0, 65.0, 69.0, 65.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 81.0, 80.0, 81.0, 96.0, 82.0, 89.0, 90.0, 82.0, 81.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 141.0, 156.0, 134.0, 148.0, 146.0, 136.0, 222.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 178.0, 183.0, 181.0, 182.0, 180.0, 180.0, 178.0, 181.0, 179.0], "value": 180.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 76.0, 77.0, 72.0, 73.0, 72.0, 76.0, 80.0], "value": 75.4, "unit": "score"}], "name": "kraken", "value": 1627.5000000000002, "alertThreshold": 2.0}]} 06:51:06 INFO - Return code: 0 06:51:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:51:06 ERROR - # TBPL SUCCESS # 06:51:06 INFO - Running post-action listener: _resource_record_post_action 06:51:06 INFO - Running post-run listener: _resource_record_post_run 06:51:07 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 530014208; Read time: 0; Write time: 646344 06:51:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 193269760; Read time: 0; Write time: 305816 06:51:07 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 295518208; Read time: 0; Write time: 327492 06:51:07 INFO - Running post-run listener: _upload_blobber_files 06:51:07 INFO - Blob upload gear active. 06:51:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:51:07 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:51:07 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:51:07 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:51:07 INFO - (blobuploader) - INFO - Open directory for files ... 06:51:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:51:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:51:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:08 INFO - (blobuploader) - INFO - Done attempting. 06:51:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:51:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:51:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:09 INFO - (blobuploader) - INFO - Done attempting. 06:51:09 INFO - (blobuploader) - INFO - Iteration through files over. 06:51:09 INFO - Return code: 0 06:51:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:51:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:51:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e481c258b8291f58f5550aea08fd9bb88ec39c2678ee3557abb721c5a57f61a9202643e827d6b5d2a6a9ae4579a873fa4c05929300cfb08b92ebceb03dbd0d94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/31eced47c01441b7f0f66236471992e8f5a54f178312c1cf8f20017b3b4cb9054a408c4cb97d0691ae3f8a58462ca30ca0cfbb8945ccc71e9f285d54d8e74c40"} 06:51:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:51:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:51:09 INFO - Contents: 06:51:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e481c258b8291f58f5550aea08fd9bb88ec39c2678ee3557abb721c5a57f61a9202643e827d6b5d2a6a9ae4579a873fa4c05929300cfb08b92ebceb03dbd0d94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/31eced47c01441b7f0f66236471992e8f5a54f178312c1cf8f20017b3b4cb9054a408c4cb97d0691ae3f8a58462ca30ca0cfbb8945ccc71e9f285d54d8e74c40"} 06:51:09 INFO - Running post-run listener: copy_logs_to_upload_dir 06:51:09 INFO - Copying logs to upload dir... 06:51:09 INFO - mkdir: /builds/slave/test/build/upload/logs 06:51:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.687414 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-21 06:51:09.572283) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 06:51:09.575538) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260 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/e481c258b8291f58f5550aea08fd9bb88ec39c2678ee3557abb721c5a57f61a9202643e827d6b5d2a6a9ae4579a873fa4c05929300cfb08b92ebceb03dbd0d94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/31eced47c01441b7f0f66236471992e8f5a54f178312c1cf8f20017b3b4cb9054a408c4cb97d0691ae3f8a58462ca30ca0cfbb8945ccc71e9f285d54d8e74c40"} build_url:https://queue.taskcluster.net/v1/task/OE9IN3UwTniw107f5n-yZg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/OE9IN3UwTniw107f5n-yZg/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/e481c258b8291f58f5550aea08fd9bb88ec39c2678ee3557abb721c5a57f61a9202643e827d6b5d2a6a9ae4579a873fa4c05929300cfb08b92ebceb03dbd0d94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/31eced47c01441b7f0f66236471992e8f5a54f178312c1cf8f20017b3b4cb9054a408c4cb97d0691ae3f8a58462ca30ca0cfbb8945ccc71e9f285d54d8e74c40"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 06:51:09.600657) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 06:51:09.601029) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1461245137.26701-680271260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 06:51:09.685043) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 06:51:09.685375) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 06:51:09.685681) ========= ========= Total master_lag: 0.17 =========