builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1467041770.51 results: success (0) buildid: 20160627055224 builduid: f822615c7bd449578e018e2a28099d00 revision: 9bd3cdd0eaa348cd04af874d41fc00116fda62c6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:36:10.509480) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:36:10.509880) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:36:10.510152) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:36:10.525103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:36:10.525408) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 08:36:11-- 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% 223M=0s 2016-06-27 08:36:11 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077269 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:36:10.621199) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:36:10.621565) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022217 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:36:10.670633) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 08:36:10.670936) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9bd3cdd0eaa348cd04af874d41fc00116fda62c6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9bd3cdd0eaa348cd04af874d41fc00116fda62c6 --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=56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 08:36:11,428 truncating revision to first 12 chars 2016-06-27 08:36:11,428 Setting DEBUG logging. 2016-06-27 08:36:11,428 attempt 1/10 2016-06-27 08:36:11,428 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9bd3cdd0eaa3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 08:36:11,765 unpacking tar archive at: mozilla-beta-9bd3cdd0eaa3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.105310 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 08:36:11.899345) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:36:11.899661) ========= script_repo_revision: 9bd3cdd0eaa348cd04af874d41fc00116fda62c6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:36:11.900051) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:36:11.900323) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:36:11.914676) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-27 08:36:11.914951) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:36:12 INFO - MultiFileLogger online at 20160627 08:36:12 in /builds/slave/test 08:36:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:36:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:36:12 INFO - {'append_to_log': False, 08:36:12 INFO - 'base_work_dir': '/builds/slave/test', 08:36:12 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:36:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:36:12 INFO - 'branch': 'Mozilla-Beta', 08:36:12 INFO - 'buildbot_json_path': 'buildprops.json', 08:36:12 INFO - 'config_files': ('talos/linux_config.py',), 08:36:12 INFO - 'default_actions': ('clobber', 08:36:12 INFO - 'read-buildbot-config', 08:36:12 INFO - 'download-and-extract', 08:36:12 INFO - 'populate-webroot', 08:36:12 INFO - 'create-virtualenv', 08:36:12 INFO - 'install', 08:36:12 INFO - 'run-tests'), 08:36:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:36:12 INFO - 'download_minidump_stackwalk': True, 08:36:12 INFO - 'download_symbols': 'ondemand', 08:36:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:36:12 INFO - 'tooltool.py': '/tools/tooltool.py', 08:36:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:36:12 INFO - '/tools/misc-python/virtualenv.py')}, 08:36:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:36:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:36:12 INFO - 'installer_path': 'installer.exe', 08:36:12 INFO - 'log_level': 'info', 08:36:12 INFO - 'log_name': 'talos', 08:36:12 INFO - 'log_to_console': True, 08:36:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:36:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:36:12 INFO - 'opt_config_files': (), 08:36:12 INFO - 'pip_index': False, 08:36:12 INFO - 'sps_profile': False, 08:36:12 INFO - 'sps_profile_interval': 0, 08:36:12 INFO - 'suite': 'dromaeojs-e10s', 08:36:12 INFO - 'system_bits': '32', 08:36:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:36:12 INFO - 'title': 'talos-linux64-ix-037', 08:36:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:36:12 INFO - 'use_talos_json': True, 08:36:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:36:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:36:12 INFO - 'work_dir': 'build'} 08:36:12 INFO - ##### 08:36:12 INFO - ##### Running clobber step. 08:36:12 INFO - ##### 08:36:12 INFO - Running pre-action listener: _resource_record_pre_action 08:36:12 INFO - Running main action method: clobber 08:36:12 INFO - rmtree: /builds/slave/test/build 08:36:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:36:13 INFO - Running post-action listener: _resource_record_post_action 08:36:13 INFO - ##### 08:36:13 INFO - ##### Running read-buildbot-config step. 08:36:13 INFO - ##### 08:36:13 INFO - Running pre-action listener: _resource_record_pre_action 08:36:13 INFO - Running main action method: read_buildbot_config 08:36:13 INFO - Using buildbot properties: 08:36:13 INFO - { 08:36:13 INFO - "project": "", 08:36:13 INFO - "product": "firefox", 08:36:13 INFO - "script_repo_revision": "production", 08:36:13 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:36:13 INFO - "repository": "", 08:36:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 08:36:13 INFO - "buildid": "20160627055224", 08:36:13 INFO - "pgo_build": "True", 08:36:13 INFO - "basedir": "/builds/slave/test", 08:36:13 INFO - "buildnumber": 17, 08:36:13 INFO - "slavename": "talos-linux64-ix-037", 08:36:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:36:13 INFO - "platform": "ubuntu64_hw", 08:36:13 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:36:13 INFO - "branch": "mozilla-beta", 08:36:13 INFO - "repo_path": "releases/mozilla-beta", 08:36:13 INFO - "revision": "9bd3cdd0eaa348cd04af874d41fc00116fda62c6", 08:36:13 INFO - "stage_platform": "linux64-pgo", 08:36:13 INFO - "builduid": "f822615c7bd449578e018e2a28099d00", 08:36:13 INFO - "slavebuilddir": "test" 08:36:13 INFO - } 08:36:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 08:36:13 INFO - Running post-action listener: _resource_record_post_action 08:36:13 INFO - ##### 08:36:13 INFO - ##### Running download-and-extract step. 08:36:13 INFO - ##### 08:36:13 INFO - Running pre-action listener: _resource_record_pre_action 08:36:13 INFO - Running main action method: download_and_extract 08:36:13 INFO - mkdir: /builds/slave/test/build/tests 08:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:13 INFO - https://queue.taskcluster.net/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:36:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:36:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:36:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:36:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:36:16 INFO - Downloaded 1327 bytes. 08:36:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:36:16 INFO - Using the following test package requirements: 08:36:16 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:36:16 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:36:16 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:36:16 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:36:16 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 08:36:16 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:36:16 INFO - u'jsshell-linux-x86_64.zip'], 08:36:16 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:36:16 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:36:16 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:36:16 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:36:16 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 08:36:16 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:36:16 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 08:36:16 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:36:16 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:36:16 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:36:16 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:36:16 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:36: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')]} 08:36:16 INFO - https://queue.taskcluster.net/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:36:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:36:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:36:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:36:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:36:19 INFO - Downloaded 24229693 bytes. 08:36:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:36:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:36:20 INFO - Return code: 0 08:36:20 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:20 INFO - https://queue.taskcluster.net/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:36:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:36:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:36:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:36:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:36:29 INFO - Downloaded 24229693 bytes. 08:36:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:36:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:36:31 INFO - Return code: 0 08:36:31 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')]} 08:36:31 INFO - https://queue.taskcluster.net/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:36:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:36:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:36:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:36:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:36:33 INFO - Downloaded 10840145 bytes. 08:36:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:36:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:36:33 INFO - Return code: 0 08:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:33 INFO - https://queue.taskcluster.net/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:36:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:36:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:36:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:36:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:36:34 INFO - Downloaded 56022945 bytes. 08:36:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:36:34 INFO - mkdir: /builds/slave/test/properties 08:36:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:36:34 INFO - Writing to file /builds/slave/test/properties/build_url 08:36:34 INFO - Contents: 08:36:34 INFO - build_url:https://queue.taskcluster.net/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:36:35 INFO - Running post-action listener: _resource_record_post_action 08:36:35 INFO - Running post-action listener: set_extra_try_arguments 08:36:35 INFO - ##### 08:36:35 INFO - ##### Running populate-webroot step. 08:36:35 INFO - ##### 08:36:35 INFO - Running pre-action listener: _resource_record_pre_action 08:36:35 INFO - Running main action method: populate_webroot 08:36:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:36:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:36:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:36:35 INFO - '--tppagecycles', 08:36:35 INFO - '7'], 08:36:35 INFO - 'tests': ['tsvgm']}}, 08:36:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:36:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:36:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:36:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:36:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:36:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:36:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:35 INFO - 'talos_options': ['--disable-e10s'], 08:36:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:36:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:36:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:35 INFO - 'talos_options': ['--disable-e10s'], 08:36:35 INFO - 'tests': ['damp', 'tps']}, 08:36:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:35 INFO - 'tests': ['damp', 'tps']}, 08:36:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:36:35 INFO - 'tests': ['dromaeo_dom']}, 08:36:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:36:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:36:35 INFO - 'tests': ['a11yr', 08:36:35 INFO - 'ts_paint', 08:36:35 INFO - 'tpaint', 08:36:35 INFO - 'sessionrestore', 08:36:35 INFO - 'sessionrestore_no_auto_restore', 08:36:35 INFO - 'tabpaint']}, 08:36:35 INFO - 'other-e10s': {'tests': ['a11yr', 08:36:35 INFO - 'ts_paint', 08:36:35 INFO - 'tpaint', 08:36:35 INFO - 'sessionrestore', 08:36:35 INFO - 'sessionrestore_no_auto_restore', 08:36:35 INFO - 'tabpaint']}, 08:36:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:36:35 INFO - 'ts_paint', 08:36:35 INFO - 'tpaint', 08:36:35 INFO - 'sessionrestore', 08:36:35 INFO - 'sessionrestore_no_auto_restore', 08:36:35 INFO - 'tabpaint']}, 08:36:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:36:35 INFO - 'ts_paint', 08:36:35 INFO - 'tpaint', 08:36:35 INFO - 'sessionrestore', 08:36:35 INFO - 'sessionrestore_no_auto_restore', 08:36:35 INFO - 'tabpaint']}, 08:36:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:36:35 INFO - 'tests': ['a11yr', 08:36:35 INFO - 'ts_paint', 08:36:35 INFO - 'tpaint', 08:36:35 INFO - 'sessionrestore', 08:36:35 INFO - 'sessionrestore_no_auto_restore', 08:36:35 INFO - 'tabpaint']}, 08:36:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:36:35 INFO - 'tests': ['a11yr', 08:36:35 INFO - 'ts_paint', 08:36:35 INFO - 'tpaint', 08:36:35 INFO - 'sessionrestore', 08:36:35 INFO - 'sessionrestore_no_auto_restore', 08:36:35 INFO - 'tabpaint']}, 08:36:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:36:35 INFO - 'tests': ['tsvgx', 08:36:35 INFO - 'tsvgr_opacity', 08:36:35 INFO - 'tart', 08:36:35 INFO - 'tscrollx', 08:36:35 INFO - 'cart']}, 08:36:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:36:35 INFO - 'tsvgr_opacity', 08:36:35 INFO - 'tart', 08:36:35 INFO - 'tscrollx', 08:36:35 INFO - 'cart']}, 08:36:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:35 INFO - 'talos_options': ['--disable-e10s'], 08:36:35 INFO - 'tests': ['tp5o']}, 08:36:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:35 INFO - 'tests': ['tp5o']}, 08:36:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:35 INFO - 'talos_options': ['--disable-e10s', 08:36:35 INFO - '--xperf_path', 08:36:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:36:35 INFO - 'tests': ['tp5n']}, 08:36:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:35 INFO - 'talos_options': ['--xperf_path', 08:36:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:36:35 INFO - 'tests': ['tp5n']}}, 08:36:35 INFO - 'talos.zip': {'path': '', 08:36:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:36:35 INFO - Running post-action listener: _resource_record_post_action 08:36:35 INFO - ##### 08:36:35 INFO - ##### Running create-virtualenv step. 08:36:35 INFO - ##### 08:36:35 INFO - Running pre-action listener: _resource_record_pre_action 08:36:35 INFO - Running main action method: create_virtualenv 08:36:35 INFO - Creating virtualenv /builds/slave/test/build/venv 08:36:35 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 08:36:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:36:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:36:35 INFO - Using real prefix '/usr' 08:36:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:36:35 INFO - Installing distribute.............................................................................................................................................................................................done. 08:36:37 INFO - Installing pip.................done. 08:36:37 INFO - Return code: 0 08:36:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:36: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')]} 08:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36: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')]} 08:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:37 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 0x7fd459d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ab5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a410>, '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 0x123b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123b7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', '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 08:36:37 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 08:36:37 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 08:36:37 INFO - Using env: {'DISPLAY': ':0', 08:36:37 INFO - 'HOME': '/home/cltbld', 08:36:37 INFO - 'LANG': 'en_US.UTF-8', 08:36:37 INFO - 'LANGUAGE': 'en_US:en', 08:36:37 INFO - 'LOGNAME': 'cltbld', 08:36:37 INFO - 'MAIL': '/var/mail/cltbld', 08:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:37 INFO - 'MOZ_NO_REMOTE': '1', 08:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:37 INFO - 'NO_EM_RESTART': '1', 08:36:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:37 INFO - 'PWD': '/builds/slave/test', 08:36:37 INFO - 'SHELL': '/bin/bash', 08:36:37 INFO - 'SHLVL': '1', 08:36:37 INFO - 'TERM': 'linux', 08:36:37 INFO - 'TMOUT': '86400', 08:36:37 INFO - 'USER': 'cltbld', 08:36:37 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', 08:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:37 INFO - '_': '/tools/buildbot/bin/python'} 08:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:38 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 08:36:38 INFO - Cleaning up... 08:36:38 INFO - Return code: 0 08:36:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:36:38 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')]} 08:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:38 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')]} 08:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:38 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 0x7fd459d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ab5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a410>, '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 0x123b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123b7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', '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 08:36:38 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 08:36:38 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 08:36:38 INFO - Using env: {'DISPLAY': ':0', 08:36:38 INFO - 'HOME': '/home/cltbld', 08:36:38 INFO - 'LANG': 'en_US.UTF-8', 08:36:38 INFO - 'LANGUAGE': 'en_US:en', 08:36:38 INFO - 'LOGNAME': 'cltbld', 08:36:38 INFO - 'MAIL': '/var/mail/cltbld', 08:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:38 INFO - 'MOZ_NO_REMOTE': '1', 08:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:38 INFO - 'NO_EM_RESTART': '1', 08:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:38 INFO - 'PWD': '/builds/slave/test', 08:36:38 INFO - 'SHELL': '/bin/bash', 08:36:38 INFO - 'SHLVL': '1', 08:36:38 INFO - 'TERM': 'linux', 08:36:38 INFO - 'TMOUT': '86400', 08:36:38 INFO - 'USER': 'cltbld', 08:36:38 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', 08:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:38 INFO - '_': '/tools/buildbot/bin/python'} 08:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:38 INFO - Downloading/unpacking psutil>=0.7.1 08:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:36:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:36:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:36:40 INFO - Installing collected packages: psutil 08:36:40 INFO - Running setup.py install for psutil 08:36:40 INFO - building 'psutil._psutil_linux' extension 08:36:40 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 08:36:40 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 08:36:40 INFO - building 'psutil._psutil_posix' extension 08:36:40 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 08:36:40 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 08:36:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:36:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:36:40 INFO - Successfully installed psutil 08:36:40 INFO - Cleaning up... 08:36:40 INFO - Return code: 0 08:36:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:40 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 0x7fd459d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ab5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a410>, '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 0x123b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123b7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', '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 08:36:40 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 08:36:40 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 08:36:40 INFO - Using env: {'DISPLAY': ':0', 08:36:40 INFO - 'HOME': '/home/cltbld', 08:36:40 INFO - 'LANG': 'en_US.UTF-8', 08:36:40 INFO - 'LANGUAGE': 'en_US:en', 08:36:40 INFO - 'LOGNAME': 'cltbld', 08:36:40 INFO - 'MAIL': '/var/mail/cltbld', 08:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:40 INFO - 'MOZ_NO_REMOTE': '1', 08:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:40 INFO - 'NO_EM_RESTART': '1', 08:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:40 INFO - 'PWD': '/builds/slave/test', 08:36:40 INFO - 'SHELL': '/bin/bash', 08:36:40 INFO - 'SHLVL': '1', 08:36:40 INFO - 'TERM': 'linux', 08:36:40 INFO - 'TMOUT': '86400', 08:36:40 INFO - 'USER': 'cltbld', 08:36:40 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', 08:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:40 INFO - '_': '/tools/buildbot/bin/python'} 08:36:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:36:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:36:43 INFO - Installing collected packages: mozsystemmonitor 08:36:43 INFO - Running setup.py install for mozsystemmonitor 08:36:43 INFO - Successfully installed mozsystemmonitor 08:36:43 INFO - Cleaning up... 08:36:43 INFO - Return code: 0 08:36:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:36: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')]} 08:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36: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')]} 08:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36: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', '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 0x7fd459d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ab5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a410>, '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 0x123b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123b7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', '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 08:36:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:36:43 INFO - Using env: {'DISPLAY': ':0', 08:36:43 INFO - 'HOME': '/home/cltbld', 08:36:43 INFO - 'LANG': 'en_US.UTF-8', 08:36:43 INFO - 'LANGUAGE': 'en_US:en', 08:36:43 INFO - 'LOGNAME': 'cltbld', 08:36:43 INFO - 'MAIL': '/var/mail/cltbld', 08:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:43 INFO - 'MOZ_NO_REMOTE': '1', 08:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:43 INFO - 'NO_EM_RESTART': '1', 08:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:43 INFO - 'PWD': '/builds/slave/test', 08:36:43 INFO - 'SHELL': '/bin/bash', 08:36:43 INFO - 'SHLVL': '1', 08:36:43 INFO - 'TERM': 'linux', 08:36:43 INFO - 'TMOUT': '86400', 08:36:43 INFO - 'USER': 'cltbld', 08:36:43 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', 08:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:43 INFO - '_': '/tools/buildbot/bin/python'} 08:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:43 INFO - Downloading/unpacking blobuploader==1.2.4 08:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:45 INFO - Downloading blobuploader-1.2.4.tar.gz 08:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:36:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:36:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:46 INFO - Downloading docopt-0.6.1.tar.gz 08:36:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:36:46 INFO - Installing collected packages: blobuploader, requests, docopt 08:36:46 INFO - Running setup.py install for blobuploader 08:36:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:36:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:36:46 INFO - Running setup.py install for requests 08:36:46 INFO - Running setup.py install for docopt 08:36:46 INFO - Successfully installed blobuploader requests docopt 08:36:46 INFO - Cleaning up... 08:36:46 INFO - Return code: 0 08:36:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:46 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')]} 08:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:46 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')]} 08:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:46 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 0x7fd459d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ab5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a410>, '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 0x123b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123b7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', '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 08:36:46 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 08:36:46 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 08:36:46 INFO - Using env: {'DISPLAY': ':0', 08:36:46 INFO - 'HOME': '/home/cltbld', 08:36:46 INFO - 'LANG': 'en_US.UTF-8', 08:36:46 INFO - 'LANGUAGE': 'en_US:en', 08:36:46 INFO - 'LOGNAME': 'cltbld', 08:36:46 INFO - 'MAIL': '/var/mail/cltbld', 08:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:46 INFO - 'MOZ_NO_REMOTE': '1', 08:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:46 INFO - 'NO_EM_RESTART': '1', 08:36:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:46 INFO - 'PWD': '/builds/slave/test', 08:36:46 INFO - 'SHELL': '/bin/bash', 08:36:46 INFO - 'SHLVL': '1', 08:36:46 INFO - 'TERM': 'linux', 08:36:46 INFO - 'TMOUT': '86400', 08:36:46 INFO - 'USER': 'cltbld', 08:36:46 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', 08:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:46 INFO - '_': '/tools/buildbot/bin/python'} 08:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:46 INFO - Running setup.py (path:/tmp/pip-PK6IqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:47 INFO - Running setup.py (path:/tmp/pip-kFltnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:47 INFO - Running setup.py (path:/tmp/pip-zTySUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:47 INFO - Running setup.py (path:/tmp/pip-srLwIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:47 INFO - Running setup.py (path:/tmp/pip-6uZdld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:47 INFO - Running setup.py (path:/tmp/pip-tHVFn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:47 INFO - Running setup.py (path:/tmp/pip-1UrCiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:47 INFO - Running setup.py (path:/tmp/pip-qrL0Ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:47 INFO - Running setup.py (path:/tmp/pip-Q_8W12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:47 INFO - Running setup.py (path:/tmp/pip-bPo0Go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:47 INFO - Running setup.py (path:/tmp/pip-4SxZMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:47 INFO - Running setup.py (path:/tmp/pip-dcszkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:47 INFO - Running setup.py (path:/tmp/pip-aZHKg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:47 INFO - Running setup.py (path:/tmp/pip-yKt1f8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:47 INFO - Running setup.py (path:/tmp/pip-Zt2kAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:48 INFO - Running setup.py (path:/tmp/pip-gOX245-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:48 INFO - Running setup.py (path:/tmp/pip-MLN5DK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:36:48 INFO - Running setup.py install for manifestparser 08:36:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:36:48 INFO - Running setup.py install for mozcrash 08:36:48 INFO - Running setup.py install for mozdebug 08:36:48 INFO - Running setup.py install for mozdevice 08:36:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:36:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:36:48 INFO - Running setup.py install for mozfile 08:36:48 INFO - Running setup.py install for mozhttpd 08:36:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:36:48 INFO - Running setup.py install for mozinfo 08:36:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:36:48 INFO - Running setup.py install for mozInstall 08:36:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:36:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:36:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:36:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:36:48 INFO - Running setup.py install for mozleak 08:36:49 INFO - Running setup.py install for mozlog 08:36:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:36:49 INFO - Running setup.py install for moznetwork 08:36:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:36:49 INFO - Running setup.py install for mozprocess 08:36:49 INFO - Running setup.py install for mozprofile 08:36:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:36:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:36:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:36:49 INFO - Running setup.py install for mozrunner 08:36:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:36:49 INFO - Running setup.py install for mozscreenshot 08:36:49 INFO - Running setup.py install for moztest 08:36:49 INFO - Running setup.py install for mozversion 08:36:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:36:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:36:49 INFO - Cleaning up... 08:36:49 INFO - Return code: 0 08:36:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36: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')]} 08:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36: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')]} 08:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:49 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 0x7fd459d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ab5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a410>, '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 0x123b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123b7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', '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 08:36:49 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 08:36:49 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 08:36:49 INFO - Using env: {'DISPLAY': ':0', 08:36:49 INFO - 'HOME': '/home/cltbld', 08:36:49 INFO - 'LANG': 'en_US.UTF-8', 08:36:49 INFO - 'LANGUAGE': 'en_US:en', 08:36:49 INFO - 'LOGNAME': 'cltbld', 08:36:49 INFO - 'MAIL': '/var/mail/cltbld', 08:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:49 INFO - 'MOZ_NO_REMOTE': '1', 08:36:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:49 INFO - 'NO_EM_RESTART': '1', 08:36:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:49 INFO - 'PWD': '/builds/slave/test', 08:36:49 INFO - 'SHELL': '/bin/bash', 08:36:49 INFO - 'SHLVL': '1', 08:36:49 INFO - 'TERM': 'linux', 08:36:49 INFO - 'TMOUT': '86400', 08:36:49 INFO - 'USER': 'cltbld', 08:36:49 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', 08:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:49 INFO - '_': '/tools/buildbot/bin/python'} 08:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:50 INFO - Running setup.py (path:/tmp/pip-qXKRUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:50 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)) 08:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:50 INFO - Running setup.py (path:/tmp/pip-Ayqjds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:50 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)) 08:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:50 INFO - Running setup.py (path:/tmp/pip-eSRamM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:50 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)) 08:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:50 INFO - Running setup.py (path:/tmp/pip-zO7zev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:50 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)) 08:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:50 INFO - Running setup.py (path:/tmp/pip-MAyfnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:50 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)) 08:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:50 INFO - Running setup.py (path:/tmp/pip-duV4Ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:50 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)) 08:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:50 INFO - Running setup.py (path:/tmp/pip-RrlEFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:50 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)) 08:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:50 INFO - Running setup.py (path:/tmp/pip-J2hcJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:50 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)) 08:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:50 INFO - Running setup.py (path:/tmp/pip-1yGaEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:50 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)) 08:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:50 INFO - Running setup.py (path:/tmp/pip-T2NWlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:50 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)) 08:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:50 INFO - Running setup.py (path:/tmp/pip-7ywaRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:50 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)) 08:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:50 INFO - Running setup.py (path:/tmp/pip-s_7IpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:51 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)) 08:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:51 INFO - Running setup.py (path:/tmp/pip-lWWdsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:51 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)) 08:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:51 INFO - Running setup.py (path:/tmp/pip-GpIoeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:51 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)) 08:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:51 INFO - Running setup.py (path:/tmp/pip-0SwlM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:51 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)) 08:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:51 INFO - Running setup.py (path:/tmp/pip-B9B6ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:51 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)) 08:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:51 INFO - Running setup.py (path:/tmp/pip-6VszUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:51 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)) 08:36:51 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)) 08:36:51 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)) 08:36:51 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)) 08:36:51 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)) 08:36:51 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)) 08:36:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:36:51 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 08:36:51 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 08:36:51 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 08:36:51 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 08:36:51 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 08:36:51 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 08:36:53 INFO - Downloading blessings-1.6.tar.gz 08:36:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:36:53 INFO - Installing collected packages: blessings 08:36:53 INFO - Running setup.py install for blessings 08:36:53 INFO - Successfully installed blessings 08:36:53 INFO - Cleaning up... 08:36:53 INFO - Return code: 0 08:36:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:36:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:53 INFO - Reading from file tmpfile_stdout 08:36:53 INFO - Current package versions: 08:36:53 INFO - argparse == 1.2.1 08:36:53 INFO - blessings == 1.6 08:36:53 INFO - blobuploader == 1.2.4 08:36:53 INFO - docopt == 0.6.1 08:36:53 INFO - manifestparser == 1.1 08:36:53 INFO - mozInstall == 1.12 08:36:53 INFO - mozcrash == 0.17 08:36:53 INFO - mozdebug == 0.1 08:36:53 INFO - mozdevice == 0.48 08:36:53 INFO - mozfile == 1.2 08:36:53 INFO - mozhttpd == 0.7 08:36:53 INFO - mozinfo == 0.9 08:36:53 INFO - mozleak == 0.1 08:36:53 INFO - mozlog == 3.1 08:36:53 INFO - moznetwork == 0.27 08:36:53 INFO - mozprocess == 0.22 08:36:53 INFO - mozprofile == 0.28 08:36:53 INFO - mozrunner == 6.11 08:36:53 INFO - mozscreenshot == 0.1 08:36:53 INFO - mozsystemmonitor == 0.0 08:36:53 INFO - moztest == 0.7 08:36:53 INFO - mozversion == 1.4 08:36:53 INFO - psutil == 3.1.1 08:36:53 INFO - requests == 1.2.3 08:36:53 INFO - wsgiref == 0.1.2 08:36:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:53 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')]} 08:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:53 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')]} 08:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:53 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 0x7fd459d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ab5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a410>, '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 0x123b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123b7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', '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 08:36:53 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 08:36:53 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 08:36:53 INFO - Using env: {'DISPLAY': ':0', 08:36:53 INFO - 'HOME': '/home/cltbld', 08:36:53 INFO - 'LANG': 'en_US.UTF-8', 08:36:53 INFO - 'LANGUAGE': 'en_US:en', 08:36:53 INFO - 'LOGNAME': 'cltbld', 08:36:53 INFO - 'MAIL': '/var/mail/cltbld', 08:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:53 INFO - 'MOZ_NO_REMOTE': '1', 08:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:53 INFO - 'NO_EM_RESTART': '1', 08:36:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:53 INFO - 'PWD': '/builds/slave/test', 08:36:53 INFO - 'SHELL': '/bin/bash', 08:36:53 INFO - 'SHLVL': '1', 08:36:53 INFO - 'TERM': 'linux', 08:36:53 INFO - 'TMOUT': '86400', 08:36:53 INFO - 'USER': 'cltbld', 08:36:53 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', 08:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:53 INFO - '_': '/tools/buildbot/bin/python'} 08:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:53 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)) 08:36:53 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)) 08:36:53 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)) 08:36:53 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)) 08:36:53 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)) 08:36:53 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)) 08:36:53 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)) 08:36:53 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)) 08:36:53 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)) 08:36:53 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)) 08:36:53 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)) 08:36:53 INFO - Cleaning up... 08:36:53 INFO - Return code: 0 08:36:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:36:53 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')]} 08:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:53 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')]} 08:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:53 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 0x7fd459d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ab5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a410>, '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 0x123b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123b7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', '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 08:36:53 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 08:36:53 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 08:36:53 INFO - Using env: {'DISPLAY': ':0', 08:36:53 INFO - 'HOME': '/home/cltbld', 08:36:53 INFO - 'LANG': 'en_US.UTF-8', 08:36:53 INFO - 'LANGUAGE': 'en_US:en', 08:36:53 INFO - 'LOGNAME': 'cltbld', 08:36:53 INFO - 'MAIL': '/var/mail/cltbld', 08:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:53 INFO - 'MOZ_NO_REMOTE': '1', 08:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:53 INFO - 'NO_EM_RESTART': '1', 08:36:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:53 INFO - 'PWD': '/builds/slave/test', 08:36:53 INFO - 'SHELL': '/bin/bash', 08:36:53 INFO - 'SHLVL': '1', 08:36:53 INFO - 'TERM': 'linux', 08:36:53 INFO - 'TMOUT': '86400', 08:36:53 INFO - 'USER': 'cltbld', 08:36:53 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', 08:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:53 INFO - '_': '/tools/buildbot/bin/python'} 08:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:54 INFO - Downloading/unpacking jsonschema 08:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:36:56 INFO - Downloading/unpacking functools32 (from jsonschema) 08:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:56 INFO - Downloading functools32-3.2.3-2.tar.gz 08:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:36:56 INFO - warning: no files found matching '*.txt' 08:36:56 INFO - no previously-included directories found matching 'build' 08:36:56 INFO - no previously-included directories found matching 'dist' 08:36:56 INFO - no previously-included directories found matching '.git*' 08:36:56 INFO - Installing collected packages: jsonschema, functools32 08:36:56 INFO - Running setup.py install for functools32 08:36:56 INFO - warning: no files found matching '*.txt' 08:36:56 INFO - no previously-included directories found matching 'build' 08:36:56 INFO - no previously-included directories found matching 'dist' 08:36:56 INFO - no previously-included directories found matching '.git*' 08:36:56 INFO - Successfully installed jsonschema functools32 08:36:56 INFO - Cleaning up... 08:36:56 INFO - Return code: 0 08:36:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:36:56 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')]} 08:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:56 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')]} 08:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:56 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 0x7fd459d5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ab5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a410>, '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 0x123b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123b7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', '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 08:36:56 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 08:36:56 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 08:36:56 INFO - Using env: {'DISPLAY': ':0', 08:36:56 INFO - 'HOME': '/home/cltbld', 08:36:56 INFO - 'LANG': 'en_US.UTF-8', 08:36:56 INFO - 'LANGUAGE': 'en_US:en', 08:36:56 INFO - 'LOGNAME': 'cltbld', 08:36:56 INFO - 'MAIL': '/var/mail/cltbld', 08:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:56 INFO - 'MOZ_NO_REMOTE': '1', 08:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:56 INFO - 'NO_EM_RESTART': '1', 08:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:56 INFO - 'PWD': '/builds/slave/test', 08:36:56 INFO - 'SHELL': '/bin/bash', 08:36:56 INFO - 'SHLVL': '1', 08:36:56 INFO - 'TERM': 'linux', 08:36:56 INFO - 'TMOUT': '86400', 08:36:56 INFO - 'USER': 'cltbld', 08:36:56 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', 08:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:56 INFO - '_': '/tools/buildbot/bin/python'} 08:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:56 INFO - Downloading/unpacking flake8 08:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:36:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:36:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:36:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:36:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:36:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:36:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:36:59 INFO - no previously-included directories found matching 'docs/_build' 08:36:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:36:59 INFO - Running setup.py install for pep8 08:36:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:36:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:36:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:36:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:36:59 INFO - no previously-included directories found matching 'docs/_build' 08:36:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:36:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:36:59 INFO - Cleaning up... 08:36:59 INFO - Return code: 0 08:36:59 INFO - Running post-action listener: _resource_record_post_action 08:36:59 INFO - Running post-action listener: _start_resource_monitoring 08:36:59 INFO - Starting resource monitoring. 08:36:59 INFO - ##### 08:36:59 INFO - ##### Running install step. 08:36:59 INFO - ##### 08:36:59 INFO - Running pre-action listener: _resource_record_pre_action 08:36:59 INFO - Running main action method: install 08:36:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:59 INFO - Reading from file tmpfile_stdout 08:36:59 INFO - Detecting whether we're running mozinstall >=1.0... 08:36:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:37:00 INFO - Reading from file tmpfile_stdout 08:37:00 INFO - Output received: 08:37:00 INFO - Usage: mozinstall [options] installer 08:37:00 INFO - Options: 08:37:00 INFO - -h, --help show this help message and exit 08:37:00 INFO - -d DEST, --destination=DEST 08:37:00 INFO - Directory to install application into. [default: 08:37:00 INFO - "/builds/slave/test"] 08:37:00 INFO - --app=APP Application being installed. [default: firefox] 08:37:00 INFO - mkdir: /builds/slave/test/build/application 08:37:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:37:13 INFO - Reading from file tmpfile_stdout 08:37:13 INFO - Output received: 08:37:13 INFO - /builds/slave/test/build/application/firefox/firefox 08:37:13 INFO - Running post-action listener: _resource_record_post_action 08:37:13 INFO - ##### 08:37:13 INFO - ##### Running run-tests step. 08:37:13 INFO - ##### 08:37:13 INFO - Running pre-action listener: _resource_record_pre_action 08:37:13 INFO - Running main action method: run_tests 08:37:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:37:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:37:13 INFO - Python 2.7.3 08:37:13 INFO - Return code: 0 08:37:13 INFO - grabbing minidump binary from tooltool 08:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:13 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 0x123a410>, '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 0x123b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123b7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:37:13 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 08:37:13 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 08:37:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:37:13 INFO - Return code: 0 08:37:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:37:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:37:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:37:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:37:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:37:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:37:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:37:14 INFO - Return code: 0 08:37:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 08:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 08:37:14 INFO - Using env: {'DISPLAY': ':0', 08:37:14 INFO - 'HOME': '/home/cltbld', 08:37:14 INFO - 'LANG': 'en_US.UTF-8', 08:37:14 INFO - 'LANGUAGE': 'en_US:en', 08:37:14 INFO - 'LOGNAME': 'cltbld', 08:37:14 INFO - 'MAIL': '/var/mail/cltbld', 08:37:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:37:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:14 INFO - 'MOZ_NO_REMOTE': '1', 08:37:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:14 INFO - 'NO_EM_RESTART': '1', 08:37:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:14 INFO - 'PWD': '/builds/slave/test', 08:37:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:37:14 INFO - 'SHELL': '/bin/bash', 08:37:14 INFO - 'SHLVL': '1', 08:37:14 INFO - 'TERM': 'linux', 08:37:14 INFO - 'TMOUT': '86400', 08:37:14 INFO - 'USER': 'cltbld', 08:37:14 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735', 08:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:14 INFO - '_': '/tools/buildbot/bin/python'} 08:37:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 08:37:14 INFO - mozversion application_buildid: 20160627055224 08:37:14 INFO - mozversion application_changeset: 9bd3cdd0eaa348cd04af874d41fc00116fda62c6 08:37:14 INFO - mozversion application_display_name: Firefox 08:37:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:37:14 INFO - mozversion application_name: Firefox 08:37:14 INFO - mozversion application_remotingname: firefox 08:37:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:37:14 INFO - mozversion application_vendor: Mozilla 08:37:14 INFO - mozversion application_version: 48.0 08:37:14 INFO - mozversion platform_buildid: 20160627055224 08:37:14 INFO - mozversion platform_changeset: 9bd3cdd0eaa348cd04af874d41fc00116fda62c6 08:37:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:37:14 INFO - mozversion platform_version: 48.0 08:37:14 INFO - using testdate: 1467041834 08:37:14 INFO - actual date: 1467041834 08:37:14 INFO - starting webserver on 'localhost:57817' 08:37:14 INFO - SUITE-START | Running 2 tests 08:37:14 INFO - TEST-START | dromaeo_css 08:37:14 INFO - operating with platform_type : linux_ 08:37:14 INFO - Initialising browser for dromaeo_css test... 08:37:14 INFO - TEST-INFO | started process 15419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWnVOIp/profile http://localhost:57817/getInfo.html) 08:37:18 INFO - PROCESS | 15419 | 08:37:18 INFO - PROCESS | 15419 | (process:15496): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:37:18 INFO - PROCESS | 15419 | __metrics Screen width/height:1600/1200 08:37:18 INFO - PROCESS | 15419 | colorDepth:24 08:37:18 INFO - PROCESS | 15419 | Browser inner width/height: 1024/697 08:37:18 INFO - PROCESS | 15419 | __metrics 08:37:19 ERROR - PROCESS | 15419 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 08:37:20 INFO - TEST-INFO | 15419: exit 0 08:37:20 INFO - Browser initialized. 08:37:20 INFO - Running cycle 1/1 for dromaeo_css test... 08:37:20 INFO - TEST-INFO | started process 15546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWnVOIp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:37:21 INFO - PROCESS | 15546 | 08:37:21 INFO - PROCESS | 15546 | (process:15612): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:37:31 INFO - PROCESS | 15546 | RSS: Main: 150855680 08:37:31 INFO - PROCESS | 15546 | 08:38:21 INFO - PROCESS | 15546 | 1467041901567 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] 08:40:29 INFO - PROCESS | 15546 | Cycle 1(1): loaded http://localhost:57817/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57817/tests/dromaeo/cssquery-ext.html) 08:40:30 INFO - PROCESS | 15546 | RSS: Main: 154152960 08:40:30 INFO - PROCESS | 15546 | 08:43:32 INFO - PROCESS | 15546 | Cycle 1(1): loaded http://localhost:57817/tests/dromaeo/cssquery-ext.html (next: http://localhost:57817/tests/dromaeo/cssquery-jquery.html) 08:43:32 INFO - PROCESS | 15546 | RSS: Main: 152227840 08:43:32 INFO - PROCESS | 15546 | 08:46:34 INFO - PROCESS | 15546 | Cycle 1(1): loaded http://localhost:57817/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57817/tests/dromaeo/cssquery-mootools.html) 08:46:34 INFO - PROCESS | 15546 | RSS: Main: 152342528 08:46:34 INFO - PROCESS | 15546 | 08:49:36 INFO - PROCESS | 15546 | Cycle 1(1): loaded http://localhost:57817/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57817/tests/dromaeo/cssquery-prototype.html) 08:49:37 INFO - PROCESS | 15546 | RSS: Main: 153096192 08:49:37 INFO - PROCESS | 15546 | 08:52:39 INFO - PROCESS | 15546 | Cycle 1(1): loaded http://localhost:57817/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57817/tests/dromaeo/cssquery-yui.html) 08:52:40 INFO - PROCESS | 15546 | RSS: Main: 151511040 08:52:40 INFO - PROCESS | 15546 | 08:55:42 INFO - PROCESS | 15546 | Cycle 1(1): loaded http://localhost:57817/tests/dromaeo/cssquery-yui.html (next: http://localhost:57817/tests/dromaeo/cssquery-dojo.html) 08:55:42 INFO - PROCESS | 15546 | RSS: Main: 155324416 08:55:42 INFO - PROCESS | 15546 | 08:55:42 INFO - PROCESS | 15546 | __start_tp_report 08:55:42 INFO - PROCESS | 15546 | _x_x_mozilla_page_load 08:55:42 INFO - PROCESS | 15546 | _x_x_mozilla_page_load_details 08:55:42 INFO - PROCESS | 15546 | |i|pagename|runs| 08:55:42 INFO - PROCESS | 15546 | |0;dojo.html;3338.2155193529516;3391.8473668684906;3402.455607102864;3423.486477028447;3444.3972304846648;5713.057345537986;5715.971420142904;5718.771249150034;5732.5987180897355;5734.627249228797;5673.914891276624;5674.404187560298;5703.57223208259;5724.7137643117885;5724.971375143118;5146.6140039497095;5166.974165129169;5223.738813059351;5248.501392367719;5263.999840030382;5163.1480805667015;5173.793048278083;5302.1781623848365;5349.491798279158;5381.650192737459;5210.192420174879;5239.764210610512;5242.580593552507;5247.606429517782;5248.71132087735;5278.287431196778;5283.973580132113;5297.417284098746;5298.390685071227;5335;5047.318611987372;5116.590672746172;5159.097157997373;5194.948050519484;5201.791928322863;5682.744276507526;5690.374058853523;5699.2306038684665;5699.515541178963;5704.828855134353;6205.379462053758;6234.501239900797;6248.218972628421;6256.0615907613765;6258.968705156445;6050.2134722486235;6114.175715401326;6220.844478888064;6221.346758590328;6272.027835685476;5757.4818266355815;5760.9711951440395;5764.855878603026;5772.826815195551;5778.59549831512;6281.120643109968;6284.308726040132;6289.276733175652;6291.276503202099;6291.307956124822;5992.580519363602;6039.4262545058145;6069.51443884497;6088.4215999479975;6129.448349648553;6085.2393450818645;6109.969450152721;6122.326544080148;6127.203463549799;6140.048292514667;5998.610090344114;6086.2087928569;6091;6091.695415229221;6091.695415229221;6128.319797384577;6175.938240617626;6189.257289125334;6199;6206;4673.948361618609;4683.531646835358;4688.484266730657;4696.2955556666775;4717.386739723883;4097.344424892062;4130.6282434581035;4141.275276826544;4172.687048471377;4209.410682504452;5853.5317174625925;5907.645541267538;5968.910466343008;5970.791022314198;5977.432143946318;6162.445379915829;6187.32942105629;6209.534284928558;6245.843853903598;6251;5689.317281926195;5934.554908381889;5964.069823743505;5968.925593393231;6018.277806663228;5288.788448462018;5307.548858347083;5312.282841816383;5314.813981510706;5364.785408583613;6461.321561236096;6481.902771458432;6485.416312531895;6485.578437401648;6488.253850807123;6106.6336019838955;6154.353792851686;6182.721777519932;6241.750329986749;6263.154474145932;6388.4569811566535;6435.646039467874;6439.06633538125;6443.226812782309;6443.710033048618;6039.305479869871;6062.272527296576;6067.635941843503;6073.392660733891;6090.634561926298;6079.422454866781;6142.590862071414;6174.475169610454;6214.40963108504;6233.065040244;6018.097285407224;6021.397860213943;6030.939690603038;6039.909401359071;6045.818625441244;5962.493188079062;6003.859266739306;6004.969975150097;6015.699215039318;6015.969920150371;5797.681127538026;5875;5921.85195370102;5967.731452084579;6003.609765365237;6030.4572588467245;6078.57449978515;6079;6095.299040610386;6097.2683278006925;5891.38140495259;5943.7028148591535;5944.702764861826;5947.1079338099635;5955.344912059583 08:55:42 INFO - PROCESS | 15546 | |1;ext.html;682.6211452643784;696.0464164095189;699.1470406104551;738.7119023580805;756.9478424989264;33857;34617.48073778895;38897.22205555891;40047.39928901062;40389.59610403895;44736;45234.321485177665;45280.3207951881;45449;45630.54369456304;8937.285017198608;9053.275737940981;9149.5882685279;9150.679726209584;9152.039035901234;8893.11068893112;9024.639014439448;9031.09689031095;9038.412503187272;9043.728688139367;9048.321375896801;9394.530273486333;9395.34232603718;9405.294602904776;9421.340506164572;9202.677906273282;9230.630774769;9279.953600231956;9298.907010929872;9307;9173.449593024374;9229.907700923039;9253.861192082124;9259.120383563552;9266.027067157918;44646;45014.099718005455;45204;45204.321935171;45216.773916130536;3789.6399842014966;3889.8055097245306;3897.610238976108;4049.007993041694;4632.3051542268595;33802.1549461263;33817.830910845536;34024.31951360959;34272;34323.14192145191;4472.709273897219;4686.33103572103;4712.528747125294;4746.881327966828;4750.667453278272;312532;313176;313292;313722;314121;66280.01159965209;66353;66731.33268667251;66945.6652716743;67035;72435;73576;74005;74124.25875741174;74272.25727742762;17655.558611034827;17913;17942.5514362142;17957.461276161735;17958.19188136537;13361.799573006412;13471.797923031163;13486.93256533711;13500.32498375097;13507.122037067757;21607.45981350479;21736.782632173792;21833.454163645718;21889;21908.12367505282;7545.245475452411;7919.20807919215;8019.839603207904;8095.392845536609;8241.299489543457;1063.7820592707124;1135.9602413915638;1168.3106966889407;1195.2171327780318;1197.3175290084741;34194.31611367759;34712;34759.82620086934;34786.82606586951;35010.64989350074;1233.210745123122;1234.179270784918;1235.9134860559675;1239.1140334660581;1312.061875758837;17527.474175774747;18002.459926202235;18129.45611631653;18178.90910545439;18184.36354727578;468802;539393;548721;894543;905824;59817.700911495165;60811.39188608057;60836.39163608396;60883;60921.08618370728;1476.763717805146;1526.6946610677908;1552.9767053493981;1556.2141118734967;1617.8867479276337;34649.30701385908;35469.46795798116;35511.46732799062;35626.64373356337;35729.28541429209;58116.4188358111;58405.12392314034;58751.70624146852;58925;59007;427754;428700;429081;429565;430620;32433.35133297368;32659.836700816344;32688.182795430304;32804.67195328112;33304.1673958153;52554;52968.73515632397;53027.46972530225;54048.45951540591;54441;43601;44040;44364;45353.092938141715;45547;38873.80563097166;38874.22251555009;39871.60128398679;39980;40395.19209615733;41261.38107928444;41722.791386042874;46297.305540416244;46729;47141.057178856914;33187.33625327528;34731.958041258804;34883.47674784931;34887.82556087305;35485;28229.858850706438;29530.261743456587;29574.40851183007;29885.551716723832;30104.657299622282 08:55:42 INFO - PROCESS | 15546 | |2;jquery.html;409.3879649923365;414.1427245601604;414.4467136372944;415.35619789326546;417.93522004089357;14622.48821291255;18289.7256541152;19068.61862762744;19096.90451547742;19137.712934305997;18336.541586460346;18530.722039169425;18749.531261718465;19307.61384772307;19464.805351946477;5746.885062298751;5790.913136302937;5968.820935371946;6003.8198854034445;6048.39516048396;5906.468417842393;5936.376680448556;5967.433093856077;5981.461668449839;5988.580799344048;5561.916571251434;5871.119332100197;5883.705814709268;5894.4989675877605;5932.703364831763;5787.21872547207;5787.73955172014;5827.329857066428;5830.4461076197695;5847.999999999979;5167.638265321429;5168.508991645787;5186.611004174702;5200.089984252741;5217.73911304437;22935.54128917429;23730.881345593334;23911.88044059786;23954.16160434394;24027.279181624406;2787.4982503149427;2911.839848808315;2938.603288556039;3083.845807709628;3098.4577698902826;14221.715565688628;15013.849861501463;15306.311215995307;15339.233038348038;15346.846531534653;1985.7120717495882;2033.8271246944028;2044.6524090904581;2045.1001559313854;2156.212982261479;79526.60236698837;79928.60035699843;81107.97230069236;82233;82569.58715206446;10765.515551800188;10809.297395669257;10828.945855270673;10914.236003479838;10933.617323393642;14669.77995330071;14756.188409637358;14822.110673359633;14835.703285934222;14848.034877732913;8017.278444939983;8077.434579579373;8111.9594402027615;8180;8234.588270586446;7693.49992250502;7982.241687039722;8016.358691304798;8139.75580732579;8213.055498617616;6758.189017317954;6786;6814.931850681529;6882;6920.169579650475;1927.6024881960748;1929.6912494000892;1955.6675365187668;1990;1992.2529051605648;444.1516703097134;1026.8973102689672;1082.334364365925;1160.709822544364;1246.9525598497305;11175.497102630401;11824.645260642023;11944;11949.76100478003;11965.940170299267;462.142725244673;469.60318530841386;480.75962018990504;480.9975950120227;504.5761560289375;6243.125962365272;6254.34329395416;6369.840753981095;6458.418742313214;6576.638284894377;475581;482281;483903;485899;492763;87626;90710.09289907017;92192.53903730438;99107;100925.49537252267;1041.5000799616228;1064.8775390829999;1105.6075093341908;1107.595727559435;1115.0800589513683;16924.238409271366;17060.488185354458;17262.360075792778;17410.651786964445;18077.638447231246;40570.59429405668;41609.37585936153;41782;42200.36699449572;42560.78719606382;56803.71598141983;60970;61602.69198653978;61857.07214391878;61942.0708689361;8758.781030474289;8810.823783524165;8869.955650221966;12371.257724536557;13088.28014459214;13876.306184690928;14876.776848347066;14966.625834353792;15004.549863504113;15485.535433937;12269.38653067361;12491.500339986298;12701.745965080832;13505.122167059502;13604.523841665494;12815.807762883751;12870.485180592672;12886.09797314179;13050.477980881038;13158;13041.282729449971;13215.933920330337;13504.122232054886;13514.72970540564;13584.117032392864;13480.191188528719;13514.93242533781;13542.796858047333;13630.727385452037;13803.51687690926;13225.80161297562;13299.069065165733;13323.800142998056;13325.600231993056;13480.258585777485 08:55:42 INFO - PROCESS | 15546 | |3;mootools.html;1580.865626421754;1587.5713557339516;1802.315120254303;1908.169946073459;1912.2924517928368;7492.325690687837;8046.0747014093395;8084.514929104251;8390.202930721587;8406.159384061599;8010.799730006753;8106.22990815873;8145.226203510671;8313.625886835092;8330.83338333233;2440.1825388494876;2477.814163937712;2489.191012920799;2501.69979602448;2505.24842547236;2438.8414753040997;2507.623856421533;2511.61070034145;2512.786413154884;2515.4969006198744;2462.8768561571937;2463;2469.8888550015295;2472.184179220862;2479.7396273391214;2462.679851619287;2473.0602371098958;2484.142970675114;2487.9751202487923;2488.8382255153447;2489.3403248139257;2500.099964012954;2511.0332521978985;2526.7978561715017;2529.2412276317214;8592.269657079156;8628.784280392978;8633;8639.265662418638;8666.39335246533;5373.301470808769;5387.057264978652;5396.703181325026;5550.69471179085;5567.916481252784;3466.4626982817704;3491.022513696169;3527.9118022049397;3554.36021516127;3596.352656521825;1196.1925700152449;1210.0924306769923;1217.190568272107;1231.0643910627898;1233.358653500184;11740.882591174064;11746.236494627907;11756.823647645293;11819.34993575353;11839;4601.976990115028;4621.19129152397;4682.367880336179;4697.4832768395445;4722.52774722525;9590.184834289024;9599.42403455795;9662.661806836868;9673.322867399214;9675.758106047406;5262.7631756571045;5309.867253318621;5377.865553361197;5379.865503362369;5387.164989426645;4334.349847522897;4859.246816743411;4911.852644420673;4922.532359425849;5012.874678133003;3964.147708242742;3981.820818063194;4067.186562687474;4068.7558746475306;4105.2405305018665;1201.2912381694841;1203.500547272872;1209.455744914792;1212.3211001839;1212.5210541835925;1056.234230183111;1084.7233955341337;1086.6142519405655;1089.9564017439213;1093.4423444043596;6139.26328840542;6281.057841323838;6309.274433440121;6314.905276420857;6333.841653958596;465.15806390433426;470.04580701176667;472.7092837904664;478.8922492439243;482.2452861272168;4144.316187828975;4216.789160541961;4277.443932288783;4312.072904325585;4327.935080973788;9942.652007179859;10221.386716797017;10343.793124137475;10397.636082737068;10515.894841051491;10131.544080516394;10156.695299140889;10164.932682068424;10220.795584088277;10230.386176829414;8046.074701409296;8119.309858661962;8167.264946154874;8200.26197642203;8215.055268644062;5852.561057920758;5864.853378665567;5899.587028907935;5919.171316015675;6043.7884674036195;8877.378583499092;8888.466691998501;8894.332925030778;9021.097890210927;9060.003399626168;8973.685920992733;9089.63641454361;9240.584173712334;9476.431414115175;9487.430754154497;7274.745383911538;7505.66224519887;7540.773776786705;7543.698252070075;7557.508761930457;8169.428140030141;8169.877451838346;8179.018517777667;8258.42191046621;8266.421350505407;7333.853322933618;7549.6225188739245;7555.962220188864;7595.278448547379;7620.276073772982;7453;7458.73894413693;7478.06524184477;7624.046994125734;7632.69469221225;6982.930170698228;7005.684744186422;7013.473989450709;7015.298470152944;7026.859462810818;5084.491550844886;5203.479652034766;5229.555487783429;5302.893942121059;5379.220013098001;5313.707746074003;5405.972970135124;5421.701806400686;5438.728063596884;5472.72636368188 08:55:42 INFO - PROCESS | 15546 | |4;prototype.html;336.4667002800561;339.69257821671385;347.93911065563526;351.9155402703352;353.05557633330835;6514.837129071776;6528.6409247491365;6591.769288074918;6634;6644.169478815148;6499.220093588764;6537.411632953033;6539.920913049353;6543.640099794509;6576.375244351779;4742.620590352781;4851.393575803025;4903.558679718824;4914.803407863681;4916.926246106311;4887.120318342697;4891.804327826882;4919.1391506486225;4919.877003074934;4934.654574179809;4820.831270905519;4867.464578896319;4867.634927380443;4868.391451068616;4871.853844384674;4860.441049279325;4861.683990540603;4873.31773551703;4875.463698993108;4876.097921884463;4204.936925946114;4208.200441916026;4208.831646734127;4210.45264115666;4215.683823713203;6156.7229474673295;6302.65335406557;6305.464035556983;6348.936510634927;6366.618002919793;5684.772609095631;5713.8285851424525;5724.885502289931;5735.512481439083;5736.139579063132;6974.755883544051;6978.511504194708;6981.89527157093;6988.567343694581;6993.0908981832035;4676.883077923045;4677.532246775329;4685.789139488731;4689.7655117244;4707.364505791743;7248.6738096785775;7312.926870731331;7315.634218289118;7322.267773222635;7334.266573342623;4710.222813235846;4774.594159496412;4789.161896668139;4796.904061918742;4801.759912004386;4825.855224343275;4856.3201151838775;4858.392700912386;4865.6107511399005;4875.9512404875495;5704.258446402024;5709.857253568611;5718.7426565804635;5723.542116630742;5733.369329373765;7053.68258428372;7054.047703560056;7060.364567188978;7062.540934839219;7065.717371305091;1712.9571760706083;1715.8627309815186;1715.8627309815186;1716.742488626716;1717.4933394648608;1048.2819268800895;1079.082779637302;1081.853949716794;1094.3816743539874;1095.0965453500894;6787.660616969132;6810.8297292567095;6811.897821532681;6827.0783444235385;6834.931650683529;7240.094988126484;7242;7248.275172482709;7269.6728647211;7301.744438944612;6689.531732778659;6892.655367231619;6937.202221744463;6979.1973922999505;7041.366277035091;3962.227365663726;4015.658669013108;4018.738781979162;4023.8591649292134;4028.3756017817286;7691.115521714963;7694.345980591601;7732.884006739903;7734.419918506134;7737.381009519225;7234.312740289664;7500.624968751541;7519.248075192437;7541.208173141851;7546.811329716801;7586.089669239726;7649.808754781064;7687.308142267111;7725.5364678119495;7731.072271327364;7405.666744996596;7406.481546291708;7406.814829629302;7407.59258240802;7412.147603025721;7225.602591857499;7235.565866048054;7241.674124664508;7255.056842610426;7271.200167981412;7400.666969986256;7599.544027358376;7642.65608047628;7643.121041080347;7682.769516914502;4795.112904112751;4879.4876537963;4881.58506526935;4917;4919.114559379346;7371.299726525972;7373.262673732798;7378.9631051846545;7381;7381.778546643609;7075.469339799639;7112.217656057933;7131.179914309713;7134.750283740044;7142.107236595426;6940.618265995418;7063.611501367474;7073.82315442118;7082.858342833218;7122.928770712227;6904.620245886525;6970.059042029261;6985.3713165815325;7003.439724822104;7008.264132266243;7103.715851365888;7142.357187853118;7161.140663120251;7174.713011479691;7181.425485961215;6932.688029038604;6953.756618518328;6974.895376569254;6979.022936788752;6985.336393042653 08:55:42 INFO - PROCESS | 15546 | |5;yui.html;799.0172088331351;819.1971867569783;843.3716880923713;854.2354592639588;868.9869651955222;15019.549413517585;15114.093154410742;15257.771133433007;15272.312745926432;15274.92362538187;13389.531366402178;13447.529336473226;13447.932760336209;13486.797698034537;13493.865061349383;887.9200871921526;894.3247847874845;921.9907800921972;923.7921467669754;926.8934072581671;915.1671978499567;916.3906002508324;919.5999740113039;920.7974245665943;922.1746536849515;962.7448726087592;963.5037955452947;965.4159233663638;965.7247684409945;966.3380584299742;954.4082668745353;955.1833182628822;955.3933252384751;957.9185769209626;959.8800149981253;703.2510376449065;703.5778532880231;703.5989485992986;703.8627467643812;707.0631413377296;15385.846141538554;15435.151066691327;15453.613659658486;15458.690826183525;15470.149141797197;14618.926905365512;14642.853571464255;14668.486602968846;14812.777808332883;14854.960152789308;11643.767124657545;11720.589779357682;12084.154109212359;12130.939345303217;12345.69135771604;3900.2979463696524;3920.4511368408444;3944.270309992632;3954.5452272988687;4000.5399379071487;57948.42051579472;57967.71016144892;58048.41951580472;58194;58399.708001460145;9660.17888479473;9837.311388202757;9901.900980990242;10024.19806415485;10124.595016199417;18897.24411023571;18940.71588926167;18946.52633684169;18979.33572324962;18986.145623446977;7617.124030736425;7692.307692307719;7968.282854543119;8011.759647210593;8209;4858.65989380747;4886.486918873538;4904.386951631046;4907.730074845917;5003.624728145403;3426.1777173478686;3455.222574920673;3458.1008937675883;3461.2039230977016;3471.1669199391963;609.9481544068803;616.8396216983526;617.1945610977627;617.4473845907887;626.971786269619;604.2658170323078;617.7004152985799;634.1502386801616;637.1797353024356;642.4218203616782;9541.52292385378;9814.754631134136;9922.206223502102;9977.900220997843;10151.035651613085;741.1476801678114;784.517521724147;789.4789438970253;797.8364435290752;803.9115697273295;4425.933610995838;4427.933580996288;4451.443569553806;4510.887227819331;4605.40129783126;61507.38492615106;61761.38238617646;61962.38037619566;62041;62202.68898655478;55233;56742.716286418305;57708.13437798437;57798.13302800462;58062.7096864513;48836;49266.507334926195;50281.49718502768;51086.23370649443;51190.23214651783;9231.86152207704;9306.953465232631;9396.013418591223;9551.665691700757;9663.565139568876;37172;37714.622853771114;38630.80684596559;39028.609713903636;39200.60799391969;43910.58491782982;45243.547564523935;47210;48106.27840582464;48407.757961209965;11663.416829158678;11896.107791915814;11984.101192410779;12160.45277962476;12343.135980481638;13062.608121756362;13127.803082953955;13624;13741;14515.201663908587;12472.617336571271;12536.185147965352;12643.114981951543;12688.365581721062;12727.23636581808;12224.572139975058;12439.253644781342;12743.681407964876;12776.425060872469;12819.487220511448;11976.820347694966;12473.93763031179;12554.686132846751;12673.93663031679;12962.611121666365;10701.19741019411;10797.190210734068;10849.186311026862;10967.341959482137;11081.27971681838;10656.57373705043;10983.670489885317;11066.664683926561;11186.384748838893;11258.831117533407 08:55:42 INFO - PROCESS | 15546 | __end_tp_report 08:55:42 INFO - PROCESS | 15546 | __start_cc_report 08:55:42 INFO - PROCESS | 15546 | _x_x_mozilla_cycle_collect,320 08:55:42 INFO - PROCESS | 15546 | __end_cc_report 08:55:42 INFO - PROCESS | 15546 | __startTimestamp1467042942289__endTimestamp 08:55:42 INFO - PROCESS | 15546 | 08:55:42 INFO - PROCESS | 15546 | ------- Summary: start ------- 08:55:42 INFO - PROCESS | 15546 | Number of tests: 6 08:55:42 INFO - PROCESS | 15546 | 08:55:42 INFO - PROCESS | 15546 | [#0] dojo.html Cycles:165 Average:5730.34 Median:5970.79 stddev:655.07 (11.0%) stddev-sans-first:629.63 08:55:42 INFO - PROCESS | 15546 | Values: 3338.2 3391.8 3402.5 3423.5 3444.4 5713.1 5716.0 5718.8 5732.6 5734.6 5673.9 5674.4 5703.6 5724.7 5725.0 5146.6 5167.0 5223.7 5248.5 5264.0 5163.1 5173.8 5302.2 5349.5 5381.7 5210.2 5239.8 5242.6 5247.6 5248.7 5278.3 5284.0 5297.4 5298.4 5335.0 5047.3 5116.6 5159.1 5194.9 5201.8 5682.7 5690.4 5699.2 5699.5 5704.8 6205.4 6234.5 6248.2 6256.1 6259.0 6050.2 6114.2 6220.8 6221.3 6272.0 5757.5 5761.0 5764.9 5772.8 5778.6 6281.1 6284.3 6289.3 6291.3 6291.3 5992.6 6039.4 6069.5 6088.4 6129.4 6085.2 6110.0 6122.3 6127.2 6140.0 5998.6 6086.2 6091.0 6091.7 6091.7 6128.3 6175.9 6189.3 6199.0 6206.0 4673.9 4683.5 4688.5 4696.3 4717.4 4097.3 4130.6 4141.3 4172.7 4209.4 5853.5 5907.6 5968.9 5970.8 5977.4 6162.4 6187.3 6209.5 6245.8 6251.0 5689.3 5934.6 5964.1 5968.9 6018.3 5288.8 5307.5 5312.3 5314.8 5364.8 6461.3 6481.9 6485.4 6485.6 6488.3 6106.6 6154.4 6182.7 6241.8 6263.2 6388.5 6435.6 6439.1 6443.2 6443.7 6039.3 6062.3 6067.6 6073.4 6090.6 6079.4 6142.6 6174.5 6214.4 6233.1 6018.1 6021.4 6030.9 6039.9 6045.8 5962.5 6003.9 6005.0 6015.7 6016.0 5797.7 5875.0 5921.9 5967.7 6003.6 6030.5 6078.6 6079.0 6095.3 6097.3 5891.4 5943.7 5944.7 5947.1 5955.3 08:55:42 INFO - PROCESS | 15546 | 08:55:42 INFO - PROCESS | 15546 | [#1] ext.html Cycles:180 Average:64532.41 Median:237110.50 stddev:135617.92 (57.2%) stddev-sans-first:135913.64 08:55:42 INFO - PROCESS | 15546 | Values: 682.6 696.0 699.1 738.7 756.9 33857.0 34617.5 38897.2 40047.4 40389.6 44736.0 45234.3 45280.3 45449.0 45630.5 8937.3 9053.3 9149.6 9150.7 9152.0 8893.1 9024.6 9031.1 9038.4 9043.7 9048.3 9394.5 9395.3 9405.3 9421.3 9202.7 9230.6 9280.0 9298.9 9307.0 9173.4 9229.9 9253.9 9259.1 9266.0 44646.0 45014.1 45204.0 45204.3 45216.8 3789.6 3889.8 3897.6 4049.0 4632.3 33802.2 33817.8 34024.3 34272.0 34323.1 4472.7 4686.3 4712.5 4746.9 4750.7 312532.0 313176.0 313292.0 313722.0 314121.0 66280.0 66353.0 66731.3 66945.7 67035.0 72435.0 73576.0 74005.0 74124.3 74272.3 17655.6 17913.0 17942.6 17957.5 17958.2 13361.8 13471.8 13486.9 13500.3 13507.1 21607.5 21736.8 21833.5 21889.0 21908.1 7545.2 7919.2 8019.8 8095.4 8241.3 1063.8 1136.0 1168.3 1195.2 1197.3 34194.3 34712.0 34759.8 34786.8 35010.6 1233.2 1234.2 1235.9 1239.1 1312.1 17527.5 18002.5 18129.5 18178.9 18184.4 468802.0 539393.0 548721.0 894543.0 905824.0 59817.7 60811.4 60836.4 60883.0 60921.1 1476.8 1526.7 1553.0 1556.2 1617.9 34649.3 35469.5 35511.5 35626.6 35729.3 58116.4 58405.1 58751.7 58925.0 59007.0 427754.0 428700.0 429081.0 429565.0 430620.0 32433.4 32659.8 32688.2 32804.7 33304.2 52554.0 52968.7 53027.5 54048.5 54441.0 43601.0 44040.0 44364.0 45353.1 45547.0 38873.8 38874.2 39871.6 39980.0 40395.2 41261.4 41722.8 46297.3 46729.0 47141.1 33187.3 34732.0 34883.5 34887.8 35485.0 28229.9 29530.3 29574.4 29885.6 30104.7 08:55:42 INFO - PROCESS | 15546 | 08:55:42 INFO - PROCESS | 15546 | [#2] jquery.html Cycles:180 Average:29207.52 Median:23990.72 stddev:79874.24 (332.9%) stddev-sans-first:80069.04 08:55:42 INFO - PROCESS | 15546 | Values: 409.4 414.1 414.4 415.4 417.9 14622.5 18289.7 19068.6 19096.9 19137.7 18336.5 18530.7 18749.5 19307.6 19464.8 5746.9 5790.9 5968.8 6003.8 6048.4 5906.5 5936.4 5967.4 5981.5 5988.6 5561.9 5871.1 5883.7 5894.5 5932.7 5787.2 5787.7 5827.3 5830.4 5848.0 5167.6 5168.5 5186.6 5200.1 5217.7 22935.5 23730.9 23911.9 23954.2 24027.3 2787.5 2911.8 2938.6 3083.8 3098.5 14221.7 15013.8 15306.3 15339.2 15346.8 1985.7 2033.8 2044.7 2045.1 2156.2 79526.6 79928.6 81108.0 82233.0 82569.6 10765.5 10809.3 10828.9 10914.2 10933.6 14669.8 14756.2 14822.1 14835.7 14848.0 8017.3 8077.4 8112.0 8180.0 8234.6 7693.5 7982.2 8016.4 8139.8 8213.1 6758.2 6786.0 6814.9 6882.0 6920.2 1927.6 1929.7 1955.7 1990.0 1992.3 444.2 1026.9 1082.3 1160.7 1247.0 11175.5 11824.6 11944.0 11949.8 11965.9 462.1 469.6 480.8 481.0 504.6 6243.1 6254.3 6369.8 6458.4 6576.6 475581.0 482281.0 483903.0 485899.0 492763.0 87626.0 90710.1 92192.5 99107.0 100925.5 1041.5 1064.9 1105.6 1107.6 1115.1 16924.2 17060.5 17262.4 17410.7 18077.6 40570.6 41609.4 41782.0 42200.4 42560.8 56803.7 60970.0 61602.7 61857.1 61942.1 8758.8 8810.8 8870.0 12371.3 13088.3 13876.3 14876.8 14966.6 15004.5 15485.5 12269.4 12491.5 12701.7 13505.1 13604.5 12815.8 12870.5 12886.1 13050.5 13158.0 13041.3 13215.9 13504.1 13514.7 13584.1 13480.2 13514.9 13542.8 13630.7 13803.5 13225.8 13299.1 13323.8 13325.6 13480.3 08:55:42 INFO - PROCESS | 15546 | 08:55:42 INFO - PROCESS | 15546 | [#3] mootools.html Cycles:180 Average:5666.97 Median:5216.52 stddev:3035.00 (58.2%) stddev-sans-first:3027.98 08:55:42 INFO - PROCESS | 15546 | Values: 1580.9 1587.6 1802.3 1908.2 1912.3 7492.3 8046.1 8084.5 8390.2 8406.2 8010.8 8106.2 8145.2 8313.6 8330.8 2440.2 2477.8 2489.2 2501.7 2505.2 2438.8 2507.6 2511.6 2512.8 2515.5 2462.9 2463.0 2469.9 2472.2 2479.7 2462.7 2473.1 2484.1 2488.0 2488.8 2489.3 2500.1 2511.0 2526.8 2529.2 8592.3 8628.8 8633.0 8639.3 8666.4 5373.3 5387.1 5396.7 5550.7 5567.9 3466.5 3491.0 3527.9 3554.4 3596.4 1196.2 1210.1 1217.2 1231.1 1233.4 11740.9 11746.2 11756.8 11819.3 11839.0 4602.0 4621.2 4682.4 4697.5 4722.5 9590.2 9599.4 9662.7 9673.3 9675.8 5262.8 5309.9 5377.9 5379.9 5387.2 4334.3 4859.2 4911.9 4922.5 5012.9 3964.1 3981.8 4067.2 4068.8 4105.2 1201.3 1203.5 1209.5 1212.3 1212.5 1056.2 1084.7 1086.6 1090.0 1093.4 6139.3 6281.1 6309.3 6314.9 6333.8 465.2 470.0 472.7 478.9 482.2 4144.3 4216.8 4277.4 4312.1 4327.9 9942.7 10221.4 10343.8 10397.6 10515.9 10131.5 10156.7 10164.9 10220.8 10230.4 8046.1 8119.3 8167.3 8200.3 8215.1 5852.6 5864.9 5899.6 5919.2 6043.8 8877.4 8888.5 8894.3 9021.1 9060.0 8973.7 9089.6 9240.6 9476.4 9487.4 7274.7 7505.7 7540.8 7543.7 7557.5 8169.4 8169.9 8179.0 8258.4 8266.4 7333.9 7549.6 7556.0 7595.3 7620.3 7453.0 7458.7 7478.1 7624.0 7632.7 6982.9 7005.7 7013.5 7015.3 7026.9 5084.5 5203.5 5229.6 5302.9 5379.2 5313.7 5406.0 5421.7 5438.7 5472.7 08:55:42 INFO - PROCESS | 15546 | 08:55:42 INFO - PROCESS | 15546 | [#4] prototype.html Cycles:180 Average:5861.25 Median:6738.60 stddev:1839.47 (27.3%) stddev-sans-first:1797.28 08:55:42 INFO - PROCESS | 15546 | Values: 336.5 339.7 347.9 351.9 353.1 6514.8 6528.6 6591.8 6634.0 6644.2 6499.2 6537.4 6539.9 6543.6 6576.4 4742.6 4851.4 4903.6 4914.8 4916.9 4887.1 4891.8 4919.1 4919.9 4934.7 4820.8 4867.5 4867.6 4868.4 4871.9 4860.4 4861.7 4873.3 4875.5 4876.1 4204.9 4208.2 4208.8 4210.5 4215.7 6156.7 6302.7 6305.5 6348.9 6366.6 5684.8 5713.8 5724.9 5735.5 5736.1 6974.8 6978.5 6981.9 6988.6 6993.1 4676.9 4677.5 4685.8 4689.8 4707.4 7248.7 7312.9 7315.6 7322.3 7334.3 4710.2 4774.6 4789.2 4796.9 4801.8 4825.9 4856.3 4858.4 4865.6 4876.0 5704.3 5709.9 5718.7 5723.5 5733.4 7053.7 7054.0 7060.4 7062.5 7065.7 1713.0 1715.9 1715.9 1716.7 1717.5 1048.3 1079.1 1081.9 1094.4 1095.1 6787.7 6810.8 6811.9 6827.1 6834.9 7240.1 7242.0 7248.3 7269.7 7301.7 6689.5 6892.7 6937.2 6979.2 7041.4 3962.2 4015.7 4018.7 4023.9 4028.4 7691.1 7694.3 7732.9 7734.4 7737.4 7234.3 7500.6 7519.2 7541.2 7546.8 7586.1 7649.8 7687.3 7725.5 7731.1 7405.7 7406.5 7406.8 7407.6 7412.1 7225.6 7235.6 7241.7 7255.1 7271.2 7400.7 7599.5 7642.7 7643.1 7682.8 4795.1 4879.5 4881.6 4917.0 4919.1 7371.3 7373.3 7379.0 7381.0 7381.8 7075.5 7112.2 7131.2 7134.8 7142.1 6940.6 7063.6 7073.8 7082.9 7122.9 6904.6 6970.1 6985.4 7003.4 7008.3 7103.7 7142.4 7161.1 7174.7 7181.4 6932.7 6953.8 6974.9 6979.0 6985.3 08:55:42 INFO - PROCESS | 15546 | 08:55:42 INFO - PROCESS | 15546 | [#5] yui.html Cycles:180 Average:15233.91 Median:47658.14 stddev:17619.00 (37.0%) stddev-sans-first:17635.08 08:55:42 INFO - PROCESS | 15546 | Values: 799.0 819.2 843.4 854.2 869.0 15019.5 15114.1 15257.8 15272.3 15274.9 13389.5 13447.5 13447.9 13486.8 13493.9 887.9 894.3 922.0 923.8 926.9 915.2 916.4 919.6 920.8 922.2 962.7 963.5 965.4 965.7 966.3 954.4 955.2 955.4 957.9 959.9 703.3 703.6 703.6 703.9 707.1 15385.8 15435.2 15453.6 15458.7 15470.1 14618.9 14642.9 14668.5 14812.8 14855.0 11643.8 11720.6 12084.2 12130.9 12345.7 3900.3 3920.5 3944.3 3954.5 4000.5 57948.4 57967.7 58048.4 58194.0 58399.7 9660.2 9837.3 9901.9 10024.2 10124.6 18897.2 18940.7 18946.5 18979.3 18986.1 7617.1 7692.3 7968.3 8011.8 8209.0 4858.7 4886.5 4904.4 4907.7 5003.6 3426.2 3455.2 3458.1 3461.2 3471.2 609.9 616.8 617.2 617.4 627.0 604.3 617.7 634.2 637.2 642.4 9541.5 9814.8 9922.2 9977.9 10151.0 741.1 784.5 789.5 797.8 803.9 4425.9 4427.9 4451.4 4510.9 4605.4 61507.4 61761.4 61962.4 62041.0 62202.7 55233.0 56742.7 57708.1 57798.1 58062.7 48836.0 49266.5 50281.5 51086.2 51190.2 9231.9 9307.0 9396.0 9551.7 9663.6 37172.0 37714.6 38630.8 39028.6 39200.6 43910.6 45243.5 47210.0 48106.3 48407.8 11663.4 11896.1 11984.1 12160.5 12343.1 13062.6 13127.8 13624.0 13741.0 14515.2 12472.6 12536.2 12643.1 12688.4 12727.2 12224.6 12439.3 12743.7 12776.4 12819.5 11976.8 12473.9 12554.7 12673.9 12962.6 10701.2 10797.2 10849.2 10967.3 11081.3 10656.6 10983.7 11066.7 11186.4 11258.8 08:55:42 INFO - PROCESS | 15546 | -------- Summary: end -------- 08:55:42 INFO - PROCESS | 15546 | 08:55:42 INFO - TEST-INFO | 15546: exit 0 08:55:42 INFO - TEST-OK | dromaeo_css | took 1108463ms 08:55:42 INFO - TEST-START | kraken 08:55:42 INFO - operating with platform_type : linux_ 08:55:42 INFO - Initialising browser for kraken test... 08:55:42 INFO - TEST-INFO | started process 15786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQtWU1U/profile http://localhost:57817/getInfo.html) 08:55:46 INFO - PROCESS | 15786 | 08:55:46 INFO - PROCESS | 15786 | (process:15862): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:55:47 INFO - PROCESS | 15786 | __metrics Screen width/height:1600/1200 08:55:47 INFO - PROCESS | 15786 | colorDepth:24 08:55:47 INFO - PROCESS | 15786 | Browser inner width/height: 1024/697 08:55:47 INFO - PROCESS | 15786 | __metrics 08:55:47 ERROR - PROCESS | 15786 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 08:55:48 INFO - TEST-INFO | 15786: exit 0 08:55:48 INFO - Browser initialized. 08:55:48 INFO - Running cycle 1/1 for kraken test... 08:55:48 INFO - TEST-INFO | started process 15912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQtWU1U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:50 INFO - PROCESS | 15912 | 08:55:50 INFO - PROCESS | 15912 | (process:15980): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:56:00 INFO - PROCESS | 15912 | RSS: Main: 150777856 08:56:00 INFO - PROCESS | 15912 | 08:56:02 INFO - PROCESS | 15912 | Cycle 1(1): loaded http://localhost:57817/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57817/tests/kraken/driver.html?testName=audio-beat-detection) 08:56:03 INFO - PROCESS | 15912 | RSS: Main: 156418048 08:56:03 INFO - PROCESS | 15912 | 08:56:06 INFO - PROCESS | 15912 | Cycle 1(1): loaded http://localhost:57817/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57817/tests/kraken/driver.html?testName=audio-dft) 08:56:06 INFO - PROCESS | 15912 | RSS: Main: 155971584 08:56:06 INFO - PROCESS | 15912 | 08:56:09 INFO - PROCESS | 15912 | Cycle 1(1): loaded http://localhost:57817/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57817/tests/kraken/driver.html?testName=audio-fft) 08:56:10 INFO - PROCESS | 15912 | RSS: Main: 156348416 08:56:10 INFO - PROCESS | 15912 | 08:56:12 INFO - PROCESS | 15912 | Cycle 1(1): loaded http://localhost:57817/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57817/tests/kraken/driver.html?testName=audio-oscillator) 08:56:12 INFO - PROCESS | 15912 | RSS: Main: 155848704 08:56:12 INFO - PROCESS | 15912 | 08:56:15 INFO - PROCESS | 15912 | Cycle 1(1): loaded http://localhost:57817/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57817/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:56:15 INFO - PROCESS | 15912 | RSS: Main: 155901952 08:56:15 INFO - PROCESS | 15912 | 08:56:18 INFO - PROCESS | 15912 | Cycle 1(1): loaded http://localhost:57817/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57817/tests/kraken/driver.html?testName=imaging-darkroom) 08:56:19 INFO - PROCESS | 15912 | RSS: Main: 156286976 08:56:19 INFO - PROCESS | 15912 | 08:56:22 INFO - PROCESS | 15912 | Cycle 1(1): loaded http://localhost:57817/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57817/tests/kraken/driver.html?testName=imaging-desaturate) 08:56:23 INFO - PROCESS | 15912 | RSS: Main: 156151808 08:56:23 INFO - PROCESS | 15912 | 08:56:26 INFO - PROCESS | 15912 | Cycle 1(1): loaded http://localhost:57817/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57817/tests/kraken/driver.html?testName=json-parse-financial) 08:56:26 INFO - PROCESS | 15912 | RSS: Main: 156180480 08:56:26 INFO - PROCESS | 15912 | 08:56:28 INFO - PROCESS | 15912 | Cycle 1(1): loaded http://localhost:57817/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57817/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:56:28 INFO - PROCESS | 15912 | RSS: Main: 155815936 08:56:28 INFO - PROCESS | 15912 | 08:56:30 INFO - PROCESS | 15912 | Cycle 1(1): loaded http://localhost:57817/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57817/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:56:31 INFO - PROCESS | 15912 | RSS: Main: 156053504 08:56:31 INFO - PROCESS | 15912 | 08:56:33 INFO - PROCESS | 15912 | Cycle 1(1): loaded http://localhost:57817/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57817/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:56:33 INFO - PROCESS | 15912 | RSS: Main: 156241920 08:56:33 INFO - PROCESS | 15912 | 08:56:36 INFO - PROCESS | 15912 | Cycle 1(1): loaded http://localhost:57817/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57817/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:56:36 INFO - PROCESS | 15912 | RSS: Main: 156721152 08:56:36 INFO - PROCESS | 15912 | 08:56:39 INFO - PROCESS | 15912 | Cycle 1(1): loaded http://localhost:57817/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57817/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:56:40 INFO - PROCESS | 15912 | RSS: Main: 156614656 08:56:40 INFO - PROCESS | 15912 | 08:56:41 INFO - PROCESS | 15912 | Cycle 1(1): loaded http://localhost:57817/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57817/tests/kraken/driver.html?testName=ai-astar) 08:56:42 INFO - PROCESS | 15912 | RSS: Main: 157970432 08:56:42 INFO - PROCESS | 15912 | 08:56:42 INFO - PROCESS | 15912 | __start_tp_report 08:56:42 INFO - PROCESS | 15912 | _x_x_mozilla_page_load 08:56:42 INFO - PROCESS | 15912 | _x_x_mozilla_page_load_details 08:56:42 INFO - PROCESS | 15912 | |i|pagename|runs| 08:56:42 INFO - PROCESS | 15912 | |0;ai-astar;109;111;103;110;111;113;99;110;110;110 08:56:42 INFO - PROCESS | 15912 | |1;audio-beat-detection;155;125;154;171;124;159;150;127;185;132 08:56:42 INFO - PROCESS | 15912 | |2;audio-dft;166;165;164;165;165;166;167;166;166;163 08:56:42 INFO - PROCESS | 15912 | |3;audio-fft;76;75;77;179;86;77;78;77;163;73 08:56:42 INFO - PROCESS | 15912 | |4;audio-oscillator;92;92;142;94;92;93;148;92;91;153 08:56:42 INFO - PROCESS | 15912 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;117;117;117 08:56:42 INFO - PROCESS | 15912 | |6;imaging-darkroom;146;147;147;147;147;146;154;146;147;146 08:56:42 INFO - PROCESS | 15912 | |7;imaging-desaturate;95;95;95;95;95;96;94;95;95;94 08:56:42 INFO - PROCESS | 15912 | |8;json-parse-financial;56;55;55;61;55;57;57;73;54;55 08:56:42 INFO - PROCESS | 15912 | |9;json-stringify-tinderbox;59;59;59;59;59;57;58;59;58;58 08:56:42 INFO - PROCESS | 15912 | |10;stanford-crypto-aes;72;74;75;72;73;72;72;73;73;73 08:56:42 INFO - PROCESS | 15912 | |11;stanford-crypto-ccm;116;112;117;113;116;117;117;115;128;129 08:56:42 INFO - PROCESS | 15912 | |12;stanford-crypto-pbkdf2;159;165;159;158;162;166;159;161;162;156 08:56:42 INFO - PROCESS | 15912 | |13;stanford-crypto-sha256-iterative;68;67;67;67;65;66;68;68;66;70 08:56:42 INFO - PROCESS | 15912 | __end_tp_report 08:56:42 INFO - PROCESS | 15912 | __start_cc_report 08:56:42 INFO - PROCESS | 15912 | _x_x_mozilla_cycle_collect,867 08:56:42 INFO - PROCESS | 15912 | __end_cc_report 08:56:42 INFO - PROCESS | 15912 | __startTimestamp1467043002071__endTimestamp 08:56:42 INFO - PROCESS | 15912 | 08:56:42 INFO - PROCESS | 15912 | ------- Summary: start ------- 08:56:42 INFO - PROCESS | 15912 | Number of tests: 14 08:56:42 INFO - PROCESS | 15912 | 08:56:42 INFO - PROCESS | 15912 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.50 stddev:4.25 (3.8%) stddev-sans-first:4.50 08:56:42 INFO - PROCESS | 15912 | Values: 109.0 111.0 103.0 110.0 111.0 113.0 99.0 110.0 110.0 110.0 08:56:42 INFO - PROCESS | 15912 | 08:56:42 INFO - PROCESS | 15912 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:154.50 stddev:20.84 (13.5%) stddev-sans-first:21.96 08:56:42 INFO - PROCESS | 15912 | Values: 155.0 125.0 154.0 171.0 124.0 159.0 150.0 127.0 185.0 132.0 08:56:42 INFO - PROCESS | 15912 | 08:56:42 INFO - PROCESS | 15912 | [#2] audio-dft Cycles:10 Average:165.30 Median:166.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 08:56:42 INFO - PROCESS | 15912 | Values: 166.0 165.0 164.0 165.0 165.0 166.0 167.0 166.0 166.0 163.0 08:56:42 INFO - PROCESS | 15912 | 08:56:42 INFO - PROCESS | 15912 | [#3] audio-fft Cycles:10 Average:96.10 Median:77.00 stddev:39.80 (51.7%) stddev-sans-first:41.54 08:56:42 INFO - PROCESS | 15912 | Values: 76.0 75.0 77.0 179.0 86.0 77.0 78.0 77.0 163.0 73.0 08:56:42 INFO - PROCESS | 15912 | 08:56:42 INFO - PROCESS | 15912 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:92.00 stddev:26.89 (29.2%) stddev-sans-first:27.82 08:56:42 INFO - PROCESS | 15912 | Values: 92.0 92.0 142.0 94.0 92.0 93.0 148.0 92.0 91.0 153.0 08:56:42 INFO - PROCESS | 15912 | 08:56:42 INFO - PROCESS | 15912 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:56:42 INFO - PROCESS | 15912 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 08:56:42 INFO - PROCESS | 15912 | 08:56:42 INFO - PROCESS | 15912 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:2.41 (1.6%) stddev-sans-first:2.51 08:56:42 INFO - PROCESS | 15912 | Values: 146.0 147.0 147.0 147.0 147.0 146.0 154.0 146.0 147.0 146.0 08:56:42 INFO - PROCESS | 15912 | 08:56:42 INFO - PROCESS | 15912 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 08:56:42 INFO - PROCESS | 15912 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 94.0 95.0 95.0 94.0 08:56:42 INFO - PROCESS | 15912 | 08:56:42 INFO - PROCESS | 15912 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:56.50 stddev:5.69 (10.1%) stddev-sans-first:6.00 08:56:42 INFO - PROCESS | 15912 | Values: 56.0 55.0 55.0 61.0 55.0 57.0 57.0 73.0 54.0 55.0 08:56:42 INFO - PROCESS | 15912 | 08:56:42 INFO - PROCESS | 15912 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.00 stddev:0.71 (1.2%) stddev-sans-first:0.73 08:56:42 INFO - PROCESS | 15912 | Values: 59.0 59.0 59.0 59.0 59.0 57.0 58.0 59.0 58.0 58.0 08:56:42 INFO - PROCESS | 15912 | 08:56:42 INFO - PROCESS | 15912 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:73.00 stddev:0.99 (1.4%) stddev-sans-first:1.00 08:56:42 INFO - PROCESS | 15912 | Values: 72.0 74.0 75.0 72.0 73.0 72.0 72.0 73.0 73.0 73.0 08:56:42 INFO - PROCESS | 15912 | 08:56:42 INFO - PROCESS | 15912 | [#11] stanford-crypto-ccm Cycles:10 Average:118.00 Median:117.00 stddev:5.79 (5.0%) stddev-sans-first:6.10 08:56:42 INFO - PROCESS | 15912 | Values: 116.0 112.0 117.0 113.0 116.0 117.0 117.0 115.0 128.0 129.0 08:56:42 INFO - PROCESS | 15912 | 08:56:42 INFO - PROCESS | 15912 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:161.50 stddev:3.13 (1.9%) stddev-sans-first:3.26 08:56:42 INFO - PROCESS | 15912 | Values: 159.0 165.0 159.0 158.0 162.0 166.0 159.0 161.0 162.0 156.0 08:56:42 INFO - PROCESS | 15912 | 08:56:42 INFO - PROCESS | 15912 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.40 (2.1%) stddev-sans-first:1.45 08:56:42 INFO - PROCESS | 15912 | Values: 68.0 67.0 67.0 67.0 65.0 66.0 68.0 68.0 66.0 70.0 08:56:42 INFO - PROCESS | 15912 | -------- Summary: end -------- 08:56:42 INFO - PROCESS | 15912 | 08:56:42 INFO - TEST-INFO | 15912: exit 0 08:56:43 INFO - TEST-OK | kraken | took 60078ms 08:56:43 INFO - SUITE-END | took 1168s 08:56:43 INFO - Completed test suite (00:19:28) 08:56:43 INFO - javascript benchmark 08:56:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3338.2155193529516, 3391.8473668684906, 3402.455607102864, 3423.486477028447, 3444.3972304846648, 5713.057345537986, 5715.971420142904, 5718.771249150034, 5732.5987180897355, 5734.627249228797, 5673.914891276624, 5674.404187560298, 5703.57223208259, 5724.7137643117885, 5724.971375143118, 5146.6140039497095, 5166.974165129169, 5223.738813059351, 5248.501392367719, 5263.999840030382, 5163.1480805667015, 5173.793048278083, 5302.1781623848365, 5349.491798279158, 5381.650192737459, 5210.192420174879, 5239.764210610512, 5242.580593552507, 5247.606429517782, 5248.71132087735, 5278.287431196778, 5283.973580132113, 5297.417284098746, 5298.390685071227, 5335.0, 5047.318611987372, 5116.590672746172, 5159.097157997373, 5194.948050519484, 5201.791928322863, 5682.744276507526, 5690.374058853523, 5699.2306038684665, 5699.515541178963, 5704.828855134353, 6205.379462053758, 6234.501239900797, 6248.218972628421, 6256.0615907613765, 6258.968705156445, 6050.2134722486235, 6114.175715401326, 6220.844478888064, 6221.346758590328, 6272.027835685476, 5757.4818266355815, 5760.9711951440395, 5764.855878603026, 5772.826815195551, 5778.59549831512, 6281.120643109968, 6284.308726040132, 6289.276733175652, 6291.276503202099, 6291.307956124822, 5992.580519363602, 6039.4262545058145, 6069.51443884497, 6088.4215999479975, 6129.448349648553, 6085.2393450818645, 6109.969450152721, 6122.326544080148, 6127.203463549799, 6140.048292514667, 5998.610090344114, 6086.2087928569, 6091.0, 6091.695415229221, 6091.695415229221, 6128.319797384577, 6175.938240617626, 6189.257289125334, 6199.0, 6206.0, 4673.948361618609, 4683.531646835358, 4688.484266730657, 4696.2955556666775, 4717.386739723883, 4097.344424892062, 4130.6282434581035, 4141.275276826544, 4172.687048471377, 4209.410682504452, 5853.5317174625925, 5907.645541267538, 5968.910466343008, 5970.791022314198, 5977.432143946318, 6162.445379915829, 6187.32942105629, 6209.534284928558, 6245.843853903598, 6251.0, 5689.317281926195, 5934.554908381889, 5964.069823743505, 5968.925593393231, 6018.277806663228, 5288.788448462018, 5307.548858347083, 5312.282841816383, 5314.813981510706, 5364.785408583613, 6461.321561236096, 6481.902771458432, 6485.416312531895, 6485.578437401648, 6488.253850807123, 6106.6336019838955, 6154.353792851686, 6182.721777519932, 6241.750329986749, 6263.154474145932, 6388.4569811566535, 6435.646039467874, 6439.06633538125, 6443.226812782309, 6443.710033048618, 6039.305479869871, 6062.272527296576, 6067.635941843503, 6073.392660733891, 6090.634561926298, 6079.422454866781, 6142.590862071414, 6174.475169610454, 6214.40963108504, 6233.065040244, 6018.097285407224, 6021.397860213943, 6030.939690603038, 6039.909401359071, 6045.818625441244, 5962.493188079062, 6003.859266739306, 6004.969975150097, 6015.699215039318, 6015.969920150371, 5797.681127538026, 5875.0, 5921.85195370102, 5967.731452084579, 6003.609765365237, 6030.4572588467245, 6078.57449978515, 6079.0, 6095.299040610386, 6097.2683278006925, 5891.38140495259, 5943.7028148591535, 5944.702764861826, 5947.1079338099635, 5955.344912059583], "value": 5686.155049436974, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.6211452643784, 696.0464164095189, 699.1470406104551, 738.7119023580805, 756.9478424989264, 33857.0, 34617.48073778895, 38897.22205555891, 40047.39928901062, 40389.59610403895, 44736.0, 45234.321485177665, 45280.3207951881, 45449.0, 45630.54369456304, 8937.285017198608, 9053.275737940981, 9149.5882685279, 9150.679726209584, 9152.039035901234, 8893.11068893112, 9024.639014439448, 9031.09689031095, 9038.412503187272, 9043.728688139367, 9048.321375896801, 9394.530273486333, 9395.34232603718, 9405.294602904776, 9421.340506164572, 9202.677906273282, 9230.630774769, 9279.953600231956, 9298.907010929872, 9307.0, 9173.449593024374, 9229.907700923039, 9253.861192082124, 9259.120383563552, 9266.027067157918, 44646.0, 45014.099718005455, 45204.0, 45204.321935171, 45216.773916130536, 3789.6399842014966, 3889.8055097245306, 3897.610238976108, 4049.007993041694, 4632.3051542268595, 33802.1549461263, 33817.830910845536, 34024.31951360959, 34272.0, 34323.14192145191, 4472.709273897219, 4686.33103572103, 4712.528747125294, 4746.881327966828, 4750.667453278272, 312532.0, 313176.0, 313292.0, 313722.0, 314121.0, 66280.01159965209, 66353.0, 66731.33268667251, 66945.6652716743, 67035.0, 72435.0, 73576.0, 74005.0, 74124.25875741174, 74272.25727742762, 17655.558611034827, 17913.0, 17942.5514362142, 17957.461276161735, 17958.19188136537, 13361.799573006412, 13471.797923031163, 13486.93256533711, 13500.32498375097, 13507.122037067757, 21607.45981350479, 21736.782632173792, 21833.454163645718, 21889.0, 21908.12367505282, 7545.245475452411, 7919.20807919215, 8019.839603207904, 8095.392845536609, 8241.299489543457, 1063.7820592707124, 1135.9602413915638, 1168.3106966889407, 1195.2171327780318, 1197.3175290084741, 34194.31611367759, 34712.0, 34759.82620086934, 34786.82606586951, 35010.64989350074, 1233.210745123122, 1234.179270784918, 1235.9134860559675, 1239.1140334660581, 1312.061875758837, 17527.474175774747, 18002.459926202235, 18129.45611631653, 18178.90910545439, 18184.36354727578, 468802.0, 539393.0, 548721.0, 894543.0, 905824.0, 59817.700911495165, 60811.39188608057, 60836.39163608396, 60883.0, 60921.08618370728, 1476.763717805146, 1526.6946610677908, 1552.9767053493981, 1556.2141118734967, 1617.8867479276337, 34649.30701385908, 35469.46795798116, 35511.46732799062, 35626.64373356337, 35729.28541429209, 58116.4188358111, 58405.12392314034, 58751.70624146852, 58925.0, 59007.0, 427754.0, 428700.0, 429081.0, 429565.0, 430620.0, 32433.35133297368, 32659.836700816344, 32688.182795430304, 32804.67195328112, 33304.1673958153, 52554.0, 52968.73515632397, 53027.46972530225, 54048.45951540591, 54441.0, 43601.0, 44040.0, 44364.0, 45353.092938141715, 45547.0, 38873.80563097166, 38874.22251555009, 39871.60128398679, 39980.0, 40395.19209615733, 41261.38107928444, 41722.791386042874, 46297.305540416244, 46729.0, 47141.057178856914, 33187.33625327528, 34731.958041258804, 34883.47674784931, 34887.82556087305, 35485.0, 28229.858850706438, 29530.261743456587, 29574.40851183007, 29885.551716723832, 30104.657299622282], "value": 21578.930871633867, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.3879649923365, 414.1427245601604, 414.4467136372944, 415.35619789326546, 417.93522004089357, 14622.48821291255, 18289.7256541152, 19068.61862762744, 19096.90451547742, 19137.712934305997, 18336.541586460346, 18530.722039169425, 18749.531261718465, 19307.61384772307, 19464.805351946477, 5746.885062298751, 5790.913136302937, 5968.820935371946, 6003.8198854034445, 6048.39516048396, 5906.468417842393, 5936.376680448556, 5967.433093856077, 5981.461668449839, 5988.580799344048, 5561.916571251434, 5871.119332100197, 5883.705814709268, 5894.4989675877605, 5932.703364831763, 5787.21872547207, 5787.73955172014, 5827.329857066428, 5830.4461076197695, 5847.999999999979, 5167.638265321429, 5168.508991645787, 5186.611004174702, 5200.089984252741, 5217.73911304437, 22935.54128917429, 23730.881345593334, 23911.88044059786, 23954.16160434394, 24027.279181624406, 2787.4982503149427, 2911.839848808315, 2938.603288556039, 3083.845807709628, 3098.4577698902826, 14221.715565688628, 15013.849861501463, 15306.311215995307, 15339.233038348038, 15346.846531534653, 1985.7120717495882, 2033.8271246944028, 2044.6524090904581, 2045.1001559313854, 2156.212982261479, 79526.60236698837, 79928.60035699843, 81107.97230069236, 82233.0, 82569.58715206446, 10765.515551800188, 10809.297395669257, 10828.945855270673, 10914.236003479838, 10933.617323393642, 14669.77995330071, 14756.188409637358, 14822.110673359633, 14835.703285934222, 14848.034877732913, 8017.278444939983, 8077.434579579373, 8111.9594402027615, 8180.0, 8234.588270586446, 7693.49992250502, 7982.241687039722, 8016.358691304798, 8139.75580732579, 8213.055498617616, 6758.189017317954, 6786.0, 6814.931850681529, 6882.0, 6920.169579650475, 1927.6024881960748, 1929.6912494000892, 1955.6675365187668, 1990.0, 1992.2529051605648, 444.1516703097134, 1026.8973102689672, 1082.334364365925, 1160.709822544364, 1246.9525598497305, 11175.497102630401, 11824.645260642023, 11944.0, 11949.76100478003, 11965.940170299267, 462.142725244673, 469.60318530841386, 480.75962018990504, 480.9975950120227, 504.5761560289375, 6243.125962365272, 6254.34329395416, 6369.840753981095, 6458.418742313214, 6576.638284894377, 475581.0, 482281.0, 483903.0, 485899.0, 492763.0, 87626.0, 90710.09289907017, 92192.53903730438, 99107.0, 100925.49537252267, 1041.5000799616228, 1064.8775390829999, 1105.6075093341908, 1107.595727559435, 1115.0800589513683, 16924.238409271366, 17060.488185354458, 17262.360075792778, 17410.651786964445, 18077.638447231246, 40570.59429405668, 41609.37585936153, 41782.0, 42200.36699449572, 42560.78719606382, 56803.71598141983, 60970.0, 61602.69198653978, 61857.07214391878, 61942.0708689361, 8758.781030474289, 8810.823783524165, 8869.955650221966, 12371.257724536557, 13088.28014459214, 13876.306184690928, 14876.776848347066, 14966.625834353792, 15004.549863504113, 15485.535433937, 12269.38653067361, 12491.500339986298, 12701.745965080832, 13505.122167059502, 13604.523841665494, 12815.807762883751, 12870.485180592672, 12886.09797314179, 13050.477980881038, 13158.0, 13041.282729449971, 13215.933920330337, 13504.122232054886, 13514.72970540564, 13584.117032392864, 13480.191188528719, 13514.93242533781, 13542.796858047333, 13630.727385452037, 13803.51687690926, 13225.80161297562, 13299.069065165733, 13323.800142998056, 13325.600231993056, 13480.258585777485], "value": 9393.168523954031, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1580.865626421754, 1587.5713557339516, 1802.315120254303, 1908.169946073459, 1912.2924517928368, 7492.325690687837, 8046.0747014093395, 8084.514929104251, 8390.202930721587, 8406.159384061599, 8010.799730006753, 8106.22990815873, 8145.226203510671, 8313.625886835092, 8330.83338333233, 2440.1825388494876, 2477.814163937712, 2489.191012920799, 2501.69979602448, 2505.24842547236, 2438.8414753040997, 2507.623856421533, 2511.61070034145, 2512.786413154884, 2515.4969006198744, 2462.8768561571937, 2463.0, 2469.8888550015295, 2472.184179220862, 2479.7396273391214, 2462.679851619287, 2473.0602371098958, 2484.142970675114, 2487.9751202487923, 2488.8382255153447, 2489.3403248139257, 2500.099964012954, 2511.0332521978985, 2526.7978561715017, 2529.2412276317214, 8592.269657079156, 8628.784280392978, 8633.0, 8639.265662418638, 8666.39335246533, 5373.301470808769, 5387.057264978652, 5396.703181325026, 5550.69471179085, 5567.916481252784, 3466.4626982817704, 3491.022513696169, 3527.9118022049397, 3554.36021516127, 3596.352656521825, 1196.1925700152449, 1210.0924306769923, 1217.190568272107, 1231.0643910627898, 1233.358653500184, 11740.882591174064, 11746.236494627907, 11756.823647645293, 11819.34993575353, 11839.0, 4601.976990115028, 4621.19129152397, 4682.367880336179, 4697.4832768395445, 4722.52774722525, 9590.184834289024, 9599.42403455795, 9662.661806836868, 9673.322867399214, 9675.758106047406, 5262.7631756571045, 5309.867253318621, 5377.865553361197, 5379.865503362369, 5387.164989426645, 4334.349847522897, 4859.246816743411, 4911.852644420673, 4922.532359425849, 5012.874678133003, 3964.147708242742, 3981.820818063194, 4067.186562687474, 4068.7558746475306, 4105.2405305018665, 1201.2912381694841, 1203.500547272872, 1209.455744914792, 1212.3211001839, 1212.5210541835925, 1056.234230183111, 1084.7233955341337, 1086.6142519405655, 1089.9564017439213, 1093.4423444043596, 6139.26328840542, 6281.057841323838, 6309.274433440121, 6314.905276420857, 6333.841653958596, 465.15806390433426, 470.04580701176667, 472.7092837904664, 478.8922492439243, 482.2452861272168, 4144.316187828975, 4216.789160541961, 4277.443932288783, 4312.072904325585, 4327.935080973788, 9942.652007179859, 10221.386716797017, 10343.793124137475, 10397.636082737068, 10515.894841051491, 10131.544080516394, 10156.695299140889, 10164.932682068424, 10220.795584088277, 10230.386176829414, 8046.074701409296, 8119.309858661962, 8167.264946154874, 8200.26197642203, 8215.055268644062, 5852.561057920758, 5864.853378665567, 5899.587028907935, 5919.171316015675, 6043.7884674036195, 8877.378583499092, 8888.466691998501, 8894.332925030778, 9021.097890210927, 9060.003399626168, 8973.685920992733, 9089.63641454361, 9240.584173712334, 9476.431414115175, 9487.430754154497, 7274.745383911538, 7505.66224519887, 7540.773776786705, 7543.698252070075, 7557.508761930457, 8169.428140030141, 8169.877451838346, 8179.018517777667, 8258.42191046621, 8266.421350505407, 7333.853322933618, 7549.6225188739245, 7555.962220188864, 7595.278448547379, 7620.276073772982, 7453.0, 7458.73894413693, 7478.06524184477, 7624.046994125734, 7632.69469221225, 6982.930170698228, 7005.684744186422, 7013.473989450709, 7015.298470152944, 7026.859462810818, 5084.491550844886, 5203.479652034766, 5229.555487783429, 5302.893942121059, 5379.220013098001, 5313.707746074003, 5405.972970135124, 5421.701806400686, 5438.728063596884, 5472.72636368188], "value": 4574.420537139406, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.4667002800561, 339.69257821671385, 347.93911065563526, 351.9155402703352, 353.05557633330835, 6514.837129071776, 6528.6409247491365, 6591.769288074918, 6634.0, 6644.169478815148, 6499.220093588764, 6537.411632953033, 6539.920913049353, 6543.640099794509, 6576.375244351779, 4742.620590352781, 4851.393575803025, 4903.558679718824, 4914.803407863681, 4916.926246106311, 4887.120318342697, 4891.804327826882, 4919.1391506486225, 4919.877003074934, 4934.654574179809, 4820.831270905519, 4867.464578896319, 4867.634927380443, 4868.391451068616, 4871.853844384674, 4860.441049279325, 4861.683990540603, 4873.31773551703, 4875.463698993108, 4876.097921884463, 4204.936925946114, 4208.200441916026, 4208.831646734127, 4210.45264115666, 4215.683823713203, 6156.7229474673295, 6302.65335406557, 6305.464035556983, 6348.936510634927, 6366.618002919793, 5684.772609095631, 5713.8285851424525, 5724.885502289931, 5735.512481439083, 5736.139579063132, 6974.755883544051, 6978.511504194708, 6981.89527157093, 6988.567343694581, 6993.0908981832035, 4676.883077923045, 4677.532246775329, 4685.789139488731, 4689.7655117244, 4707.364505791743, 7248.6738096785775, 7312.926870731331, 7315.634218289118, 7322.267773222635, 7334.266573342623, 4710.222813235846, 4774.594159496412, 4789.161896668139, 4796.904061918742, 4801.759912004386, 4825.855224343275, 4856.3201151838775, 4858.392700912386, 4865.6107511399005, 4875.9512404875495, 5704.258446402024, 5709.857253568611, 5718.7426565804635, 5723.542116630742, 5733.369329373765, 7053.68258428372, 7054.047703560056, 7060.364567188978, 7062.540934839219, 7065.717371305091, 1712.9571760706083, 1715.8627309815186, 1715.8627309815186, 1716.742488626716, 1717.4933394648608, 1048.2819268800895, 1079.082779637302, 1081.853949716794, 1094.3816743539874, 1095.0965453500894, 6787.660616969132, 6810.8297292567095, 6811.897821532681, 6827.0783444235385, 6834.931650683529, 7240.094988126484, 7242.0, 7248.275172482709, 7269.6728647211, 7301.744438944612, 6689.531732778659, 6892.655367231619, 6937.202221744463, 6979.1973922999505, 7041.366277035091, 3962.227365663726, 4015.658669013108, 4018.738781979162, 4023.8591649292134, 4028.3756017817286, 7691.115521714963, 7694.345980591601, 7732.884006739903, 7734.419918506134, 7737.381009519225, 7234.312740289664, 7500.624968751541, 7519.248075192437, 7541.208173141851, 7546.811329716801, 7586.089669239726, 7649.808754781064, 7687.308142267111, 7725.5364678119495, 7731.072271327364, 7405.666744996596, 7406.481546291708, 7406.814829629302, 7407.59258240802, 7412.147603025721, 7225.602591857499, 7235.565866048054, 7241.674124664508, 7255.056842610426, 7271.200167981412, 7400.666969986256, 7599.544027358376, 7642.65608047628, 7643.121041080347, 7682.769516914502, 4795.112904112751, 4879.4876537963, 4881.58506526935, 4917.0, 4919.114559379346, 7371.299726525972, 7373.262673732798, 7378.9631051846545, 7381.0, 7381.778546643609, 7075.469339799639, 7112.217656057933, 7131.179914309713, 7134.750283740044, 7142.107236595426, 6940.618265995418, 7063.611501367474, 7073.82315442118, 7082.858342833218, 7122.928770712227, 6904.620245886525, 6970.059042029261, 6985.3713165815325, 7003.439724822104, 7008.264132266243, 7103.715851365888, 7142.357187853118, 7161.140663120251, 7174.713011479691, 7181.425485961215, 6932.688029038604, 6953.756618518328, 6974.895376569254, 6979.022936788752, 6985.336393042653], "value": 5246.688461522907, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.0172088331351, 819.1971867569783, 843.3716880923713, 854.2354592639588, 868.9869651955222, 15019.549413517585, 15114.093154410742, 15257.771133433007, 15272.312745926432, 15274.92362538187, 13389.531366402178, 13447.529336473226, 13447.932760336209, 13486.797698034537, 13493.865061349383, 887.9200871921526, 894.3247847874845, 921.9907800921972, 923.7921467669754, 926.8934072581671, 915.1671978499567, 916.3906002508324, 919.5999740113039, 920.7974245665943, 922.1746536849515, 962.7448726087592, 963.5037955452947, 965.4159233663638, 965.7247684409945, 966.3380584299742, 954.4082668745353, 955.1833182628822, 955.3933252384751, 957.9185769209626, 959.8800149981253, 703.2510376449065, 703.5778532880231, 703.5989485992986, 703.8627467643812, 707.0631413377296, 15385.846141538554, 15435.151066691327, 15453.613659658486, 15458.690826183525, 15470.149141797197, 14618.926905365512, 14642.853571464255, 14668.486602968846, 14812.777808332883, 14854.960152789308, 11643.767124657545, 11720.589779357682, 12084.154109212359, 12130.939345303217, 12345.69135771604, 3900.2979463696524, 3920.4511368408444, 3944.270309992632, 3954.5452272988687, 4000.5399379071487, 57948.42051579472, 57967.71016144892, 58048.41951580472, 58194.0, 58399.708001460145, 9660.17888479473, 9837.311388202757, 9901.900980990242, 10024.19806415485, 10124.595016199417, 18897.24411023571, 18940.71588926167, 18946.52633684169, 18979.33572324962, 18986.145623446977, 7617.124030736425, 7692.307692307719, 7968.282854543119, 8011.759647210593, 8209.0, 4858.65989380747, 4886.486918873538, 4904.386951631046, 4907.730074845917, 5003.624728145403, 3426.1777173478686, 3455.222574920673, 3458.1008937675883, 3461.2039230977016, 3471.1669199391963, 609.9481544068803, 616.8396216983526, 617.1945610977627, 617.4473845907887, 626.971786269619, 604.2658170323078, 617.7004152985799, 634.1502386801616, 637.1797353024356, 642.4218203616782, 9541.52292385378, 9814.754631134136, 9922.206223502102, 9977.900220997843, 10151.035651613085, 741.1476801678114, 784.517521724147, 789.4789438970253, 797.8364435290752, 803.9115697273295, 4425.933610995838, 4427.933580996288, 4451.443569553806, 4510.887227819331, 4605.40129783126, 61507.38492615106, 61761.38238617646, 61962.38037619566, 62041.0, 62202.68898655478, 55233.0, 56742.716286418305, 57708.13437798437, 57798.13302800462, 58062.7096864513, 48836.0, 49266.507334926195, 50281.49718502768, 51086.23370649443, 51190.23214651783, 9231.86152207704, 9306.953465232631, 9396.013418591223, 9551.665691700757, 9663.565139568876, 37172.0, 37714.622853771114, 38630.80684596559, 39028.609713903636, 39200.60799391969, 43910.58491782982, 45243.547564523935, 47210.0, 48106.27840582464, 48407.757961209965, 11663.416829158678, 11896.107791915814, 11984.101192410779, 12160.45277962476, 12343.135980481638, 13062.608121756362, 13127.803082953955, 13624.0, 13741.0, 14515.201663908587, 12472.617336571271, 12536.185147965352, 12643.114981951543, 12688.365581721062, 12727.23636581808, 12224.572139975058, 12439.253644781342, 12743.681407964876, 12776.425060872469, 12819.487220511448, 11976.820347694966, 12473.93763031179, 12554.686132846751, 12673.93663031679, 12962.611121666365, 10701.19741019411, 10797.190210734068, 10849.186311026862, 10967.341959482137, 11081.27971681838, 10656.57373705043, 10983.670489885317, 11066.664683926561, 11186.384748838893, 11258.831117533407], "value": 6973.438742979806, "unit": "score"}], "name": "dromaeo_css", "value": 7601.42186079777, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 103.0, 110.0, 111.0, 113.0, 99.0, 110.0, 110.0, 110.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 154.0, 171.0, 124.0, 159.0, 150.0, 127.0, 185.0, 132.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 164.0, 165.0, 165.0, 166.0, 167.0, 166.0, 166.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 179.0, 86.0, 77.0, 78.0, 77.0, 163.0, 73.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 142.0, 94.0, 92.0, 93.0, 148.0, 92.0, 91.0, 153.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 154.0, 146.0, 147.0, 146.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 61.0, 55.0, 57.0, 57.0, 73.0, 54.0, 55.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 57.0, 58.0, 59.0, 58.0, 58.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 75.0, 72.0, 73.0, 72.0, 72.0, 73.0, 73.0, 73.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 117.0, 113.0, 116.0, 117.0, 117.0, 115.0, 128.0, 129.0], "value": 118.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 165.0, 159.0, 158.0, 162.0, 166.0, 159.0, 161.0, 162.0, 156.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 65.0, 66.0, 68.0, 68.0, 66.0, 70.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1521.2, "alertThreshold": 2.0}]} 08:56:43 INFO - Return code: 0 08:56:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:56:43 ERROR - # TBPL SUCCESS # 08:56:43 INFO - Running post-action listener: _resource_record_post_action 08:56:43 INFO - Running post-run listener: _resource_record_post_run 08:56:44 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 466780160; Read time: 0; Write time: 307736 08:56:44 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 241881088; Read time: 0; Write time: 200472 08:56:44 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 224575488; Read time: 0; Write time: 107240 08:56:44 INFO - Running post-run listener: _upload_blobber_files 08:56:44 INFO - Blob upload gear active. 08:56:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:56:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:56:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:56:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:56:44 INFO - (blobuploader) - INFO - Open directory for files ... 08:56:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:56:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:56:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:45 INFO - (blobuploader) - INFO - Done attempting. 08:56:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:56:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:56:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:46 INFO - (blobuploader) - INFO - Done attempting. 08:56:46 INFO - (blobuploader) - INFO - Iteration through files over. 08:56:46 INFO - Return code: 0 08:56:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:56:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:56:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/966fe19c48c9cbdca0b7bcb18ffc0fb36289ecf4bf2edfa9ade9f19b2d5bf2c824bb730f708da7b249b8d99758bc341e277b5ad3d6ccf72d6e33e502dd653df6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83a4c5bca5720bb86944ab6b1732d6439f7bd41534481db19a8fb41115eca823c7783a9b15409e71217f641109870e103042aabc7ffc0a7365cb44d1db16c5bf"} 08:56:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:56:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:56:46 INFO - Contents: 08:56:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/966fe19c48c9cbdca0b7bcb18ffc0fb36289ecf4bf2edfa9ade9f19b2d5bf2c824bb730f708da7b249b8d99758bc341e277b5ad3d6ccf72d6e33e502dd653df6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83a4c5bca5720bb86944ab6b1732d6439f7bd41534481db19a8fb41115eca823c7783a9b15409e71217f641109870e103042aabc7ffc0a7365cb44d1db16c5bf"} 08:56:46 INFO - Running post-run listener: copy_logs_to_upload_dir 08:56:46 INFO - Copying logs to upload dir... 08:56:46 INFO - mkdir: /builds/slave/test/build/upload/logs 08:56:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.745622 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-27 08:56:45.683030) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:56:45.686696) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735 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/Mozilla-Beta/sha512/966fe19c48c9cbdca0b7bcb18ffc0fb36289ecf4bf2edfa9ade9f19b2d5bf2c824bb730f708da7b249b8d99758bc341e277b5ad3d6ccf72d6e33e502dd653df6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83a4c5bca5720bb86944ab6b1732d6439f7bd41534481db19a8fb41115eca823c7783a9b15409e71217f641109870e103042aabc7ffc0a7365cb44d1db16c5bf"} build_url:https://queue.taskcluster.net/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011541 build_url: 'https://queue.taskcluster.net/v1/task/d_HBmVELQEK9lg8Yb1GHiw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/966fe19c48c9cbdca0b7bcb18ffc0fb36289ecf4bf2edfa9ade9f19b2d5bf2c824bb730f708da7b249b8d99758bc341e277b5ad3d6ccf72d6e33e502dd653df6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83a4c5bca5720bb86944ab6b1732d6439f7bd41534481db19a8fb41115eca823c7783a9b15409e71217f641109870e103042aabc7ffc0a7365cb44d1db16c5bf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:56:45.711831) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:56:45.712113) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467041770.251835-207727735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:56:45.796091) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:56:45.796434) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:56:45.796720) ========= ========= Total master_lag: 0.28 =========