builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1464911111.08 results: success (0) buildid: 20160602140837 builduid: 893fdbbbce3544769bc98c5128e2bb0b revision: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 16:45:11.077887) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 16:45:11.078369) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 16:45:11.078671) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 16:45:11.093912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 16:45:11.094295) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 16:45: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% 40.7M=0s 2016-06-02 16:45:11 (40.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090753 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 16:45:11.205641) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 16:45:11.206247) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015116 ========= master_lag: 0.25 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 16:45:11.472065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 16:45:11.472425) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea --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 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea --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=82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 16:45:12,057 truncating revision to first 12 chars 2016-06-02 16:45:12,057 Setting DEBUG logging. 2016-06-02 16:45:12,057 attempt 1/10 2016-06-02 16:45:12,057 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6e2399cf03e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 16:45:13,362 unpacking tar archive at: mozilla-beta-6e2399cf03e2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.613152 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 16:45:13.102755) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 16:45:13.103056) ========= script_repo_revision: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 16:45:13.103433) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 16:45:13.103715) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 16:45:13.114368) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-06-02 16:45:13.114689) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:45:13 INFO - MultiFileLogger online at 20160602 16:45:13 in /builds/slave/test 16:45:13 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 16:45:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:45:13 INFO - {'append_to_log': False, 16:45:13 INFO - 'base_work_dir': '/builds/slave/test', 16:45:13 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:45:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:45:13 INFO - 'branch': 'Mozilla-Beta', 16:45:13 INFO - 'buildbot_json_path': 'buildprops.json', 16:45:13 INFO - 'config_files': ('talos/linux_config.py',), 16:45:13 INFO - 'default_actions': ('clobber', 16:45:13 INFO - 'read-buildbot-config', 16:45:13 INFO - 'download-and-extract', 16:45:13 INFO - 'populate-webroot', 16:45:13 INFO - 'create-virtualenv', 16:45:13 INFO - 'install', 16:45:13 INFO - 'run-tests'), 16:45:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:45:13 INFO - 'download_minidump_stackwalk': True, 16:45:13 INFO - 'download_symbols': 'ondemand', 16:45:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:45:13 INFO - 'tooltool.py': '/tools/tooltool.py', 16:45:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:45:13 INFO - '/tools/misc-python/virtualenv.py')}, 16:45:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:45:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:45:13 INFO - 'installer_path': 'installer.exe', 16:45:13 INFO - 'log_level': 'info', 16:45:13 INFO - 'log_name': 'talos', 16:45:13 INFO - 'log_to_console': True, 16:45:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:45:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:45:13 INFO - 'opt_config_files': (), 16:45:13 INFO - 'pip_index': False, 16:45:13 INFO - 'sps_profile': False, 16:45:13 INFO - 'sps_profile_interval': 0, 16:45:13 INFO - 'suite': 'dromaeojs-e10s', 16:45:13 INFO - 'system_bits': '32', 16:45:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:45:13 INFO - 'title': 'talos-linux64-ix-066', 16:45:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:45:13 INFO - 'use_talos_json': True, 16:45:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:45:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:45:13 INFO - 'work_dir': 'build'} 16:45:13 INFO - ##### 16:45:13 INFO - ##### Running clobber step. 16:45:13 INFO - ##### 16:45:13 INFO - Running pre-action listener: _resource_record_pre_action 16:45:13 INFO - Running main action method: clobber 16:45:13 INFO - rmtree: /builds/slave/test/build 16:45:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:45:14 INFO - Running post-action listener: _resource_record_post_action 16:45:14 INFO - ##### 16:45:14 INFO - ##### Running read-buildbot-config step. 16:45:14 INFO - ##### 16:45:14 INFO - Running pre-action listener: _resource_record_pre_action 16:45:14 INFO - Running main action method: read_buildbot_config 16:45:14 INFO - Using buildbot properties: 16:45:14 INFO - { 16:45:14 INFO - "project": "", 16:45:14 INFO - "product": "firefox", 16:45:14 INFO - "script_repo_revision": "production", 16:45:14 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 16:45:14 INFO - "repository": "", 16:45:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 16:45:14 INFO - "buildid": "20160602140837", 16:45:14 INFO - "pgo_build": "True", 16:45:14 INFO - "basedir": "/builds/slave/test", 16:45:14 INFO - "buildnumber": 24, 16:45:14 INFO - "slavename": "talos-linux64-ix-066", 16:45:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:45:14 INFO - "platform": "ubuntu64_hw", 16:45:14 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:45:14 INFO - "branch": "mozilla-beta", 16:45:14 INFO - "repo_path": "releases/mozilla-beta", 16:45:14 INFO - "revision": "6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea", 16:45:14 INFO - "stage_platform": "linux64-pgo", 16:45:14 INFO - "builduid": "893fdbbbce3544769bc98c5128e2bb0b", 16:45:14 INFO - "slavebuilddir": "test" 16:45:14 INFO - } 16:45:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 16:45:14 INFO - Running post-action listener: _resource_record_post_action 16:45:14 INFO - ##### 16:45:14 INFO - ##### Running download-and-extract step. 16:45:14 INFO - ##### 16:45:14 INFO - Running pre-action listener: _resource_record_pre_action 16:45:14 INFO - Running main action method: download_and_extract 16:45:14 INFO - mkdir: /builds/slave/test/build/tests 16:45:14 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')]} 16:45:14 INFO - https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:45:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:45:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:45:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:45:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:45:16 INFO - Downloaded 1412 bytes. 16:45:16 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:45:16 INFO - Using the following test package requirements: 16:45:16 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:45:16 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:45:16 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:45:16 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:45:16 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 16:45:16 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:45:16 INFO - u'jsshell-linux-x86_64.zip'], 16:45:16 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:45:16 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:45:16 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:45:16 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:45:16 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 16:45:16 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:45:16 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 16:45:16 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:45:16 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:45:16 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:45:16 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:45:16 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:45:16 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:45: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')]} 16:45:16 INFO - https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:45:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:45:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:45:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:45:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:45:18 INFO - Downloaded 23434647 bytes. 16:45:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:45:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:45:19 INFO - Return code: 0 16:45:19 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:19 INFO - https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:45:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:45:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:45:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:45:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:45:21 INFO - Downloaded 23434647 bytes. 16:45:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:45:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:45:23 INFO - Return code: 0 16:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:23 INFO - https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:45:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:45:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:45:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:45:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:45:24 INFO - Downloaded 10845194 bytes. 16:45:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:45:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:45:24 INFO - Return code: 0 16:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:24 INFO - https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:45:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:45:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:45:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:45:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:45:26 INFO - Downloaded 53855842 bytes. 16:45:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:45:26 INFO - mkdir: /builds/slave/test/properties 16:45:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:45:26 INFO - Writing to file /builds/slave/test/properties/build_url 16:45:26 INFO - Contents: 16:45:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:45:27 INFO - Running post-action listener: _resource_record_post_action 16:45:27 INFO - Running post-action listener: set_extra_try_arguments 16:45:27 INFO - ##### 16:45:27 INFO - ##### Running populate-webroot step. 16:45:27 INFO - ##### 16:45:27 INFO - Running pre-action listener: _resource_record_pre_action 16:45:27 INFO - Running main action method: populate_webroot 16:45:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:45:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:45:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:45:27 INFO - '--tppagecycles', 16:45:27 INFO - '7'], 16:45:27 INFO - 'tests': ['tsvgm']}}, 16:45:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:45:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:45:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:45:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:45:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:45:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:45:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:45:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:27 INFO - 'talos_options': ['--e10s'], 16:45:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:45:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:27 INFO - 'tests': ['damp', 'tps']}, 16:45:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:27 INFO - 'talos_options': ['--e10s'], 16:45:27 INFO - 'tests': ['damp', 'tps']}, 16:45:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:45:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:45:27 INFO - 'other': {'tests': ['a11yr', 16:45:27 INFO - 'ts_paint', 16:45:27 INFO - 'tpaint', 16:45:27 INFO - 'sessionrestore', 16:45:27 INFO - 'sessionrestore_no_auto_restore', 16:45:27 INFO - 'tabpaint']}, 16:45:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:45:27 INFO - 'tests': ['a11yr', 16:45:27 INFO - 'ts_paint', 16:45:27 INFO - 'tpaint', 16:45:27 INFO - 'sessionrestore', 16:45:27 INFO - 'sessionrestore_no_auto_restore', 16:45:27 INFO - 'tabpaint']}, 16:45:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:45:27 INFO - 'tests': ['a11yr', 16:45:27 INFO - 'ts_paint', 16:45:27 INFO - 'tpaint', 16:45:27 INFO - 'sessionrestore', 16:45:27 INFO - 'sessionrestore_no_auto_restore', 16:45:27 INFO - 'tabpaint']}, 16:45:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:45:27 INFO - 'tests': ['a11yr', 16:45:27 INFO - 'ts_paint', 16:45:27 INFO - 'tpaint', 16:45:27 INFO - 'sessionrestore', 16:45:27 INFO - 'sessionrestore_no_auto_restore', 16:45:27 INFO - 'tabpaint']}, 16:45:27 INFO - 'other_l64': {'tests': ['a11yr', 16:45:27 INFO - 'ts_paint', 16:45:27 INFO - 'tpaint', 16:45:27 INFO - 'sessionrestore', 16:45:27 INFO - 'sessionrestore_no_auto_restore', 16:45:27 INFO - 'tabpaint']}, 16:45:27 INFO - 'other_nol64': {'tests': ['a11yr', 16:45:27 INFO - 'ts_paint', 16:45:27 INFO - 'tpaint', 16:45:27 INFO - 'sessionrestore', 16:45:27 INFO - 'sessionrestore_no_auto_restore', 16:45:27 INFO - 'tabpaint']}, 16:45:27 INFO - 'svgr': {'tests': ['tsvgx', 16:45:27 INFO - 'tsvgr_opacity', 16:45:27 INFO - 'tart', 16:45:27 INFO - 'tscrollx', 16:45:27 INFO - 'cart']}, 16:45:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:45:27 INFO - 'tests': ['tsvgx', 16:45:27 INFO - 'tsvgr_opacity', 16:45:27 INFO - 'tart', 16:45:27 INFO - 'tscrollx', 16:45:27 INFO - 'cart']}, 16:45:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:27 INFO - 'tests': ['tp5o']}, 16:45:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:27 INFO - 'talos_options': ['--e10s'], 16:45:27 INFO - 'tests': ['tp5o']}, 16:45:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:27 INFO - 'talos_options': ['--xperf_path', 16:45:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:45:27 INFO - 'tests': ['tp5n']}, 16:45:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:27 INFO - 'talos_options': ['--e10s', 16:45:27 INFO - '--xperf_path', 16:45:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:45:27 INFO - 'tests': ['tp5n']}}, 16:45:27 INFO - 'talos.zip': {'path': '', 16:45:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:45:27 INFO - Running post-action listener: _resource_record_post_action 16:45:27 INFO - ##### 16:45:27 INFO - ##### Running create-virtualenv step. 16:45:27 INFO - ##### 16:45:27 INFO - Running pre-action listener: _resource_record_pre_action 16:45:27 INFO - Running main action method: create_virtualenv 16:45:27 INFO - Creating virtualenv /builds/slave/test/build/venv 16:45:27 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 16:45:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:45:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:45:27 INFO - Using real prefix '/usr' 16:45:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:45:28 INFO - Installing distribute.............................................................................................................................................................................................done. 16:45:30 INFO - Installing pip.................done. 16:45:30 INFO - Return code: 0 16:45:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d47c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1991160>, '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 0x1992060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19924f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', '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 16:45:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:45:30 INFO - Using env: {'DISPLAY': ':0', 16:45:30 INFO - 'HOME': '/home/cltbld', 16:45:30 INFO - 'LANG': 'en_US.UTF-8', 16:45:30 INFO - 'LANGUAGE': 'en_US:en', 16:45:30 INFO - 'LOGNAME': 'cltbld', 16:45:30 INFO - 'MAIL': '/var/mail/cltbld', 16:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:30 INFO - 'MOZ_NO_REMOTE': '1', 16:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:30 INFO - 'NO_EM_RESTART': '1', 16:45:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:30 INFO - 'PWD': '/builds/slave/test', 16:45:30 INFO - 'SHELL': '/bin/bash', 16:45:30 INFO - 'SHLVL': '1', 16:45:30 INFO - 'TERM': 'linux', 16:45:30 INFO - 'TMOUT': '86400', 16:45:30 INFO - 'USER': 'cltbld', 16:45:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', 16:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:30 INFO - '_': '/tools/buildbot/bin/python'} 16:45:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:30 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 16:45:30 INFO - Cleaning up... 16:45:30 INFO - Return code: 0 16:45:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7d47c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1991160>, '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 0x1992060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19924f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', '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 16:45:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:45:30 INFO - Using env: {'DISPLAY': ':0', 16:45:30 INFO - 'HOME': '/home/cltbld', 16:45:30 INFO - 'LANG': 'en_US.UTF-8', 16:45:30 INFO - 'LANGUAGE': 'en_US:en', 16:45:30 INFO - 'LOGNAME': 'cltbld', 16:45:30 INFO - 'MAIL': '/var/mail/cltbld', 16:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:30 INFO - 'MOZ_NO_REMOTE': '1', 16:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:30 INFO - 'NO_EM_RESTART': '1', 16:45:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:30 INFO - 'PWD': '/builds/slave/test', 16:45:30 INFO - 'SHELL': '/bin/bash', 16:45:30 INFO - 'SHLVL': '1', 16:45:30 INFO - 'TERM': 'linux', 16:45:30 INFO - 'TMOUT': '86400', 16:45:30 INFO - 'USER': 'cltbld', 16:45:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', 16:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:30 INFO - '_': '/tools/buildbot/bin/python'} 16:45:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:30 INFO - Downloading/unpacking psutil>=0.7.1 16:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:45:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:45:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:45:32 INFO - Installing collected packages: psutil 16:45:32 INFO - Running setup.py install for psutil 16:45:32 INFO - building 'psutil._psutil_linux' extension 16:45:32 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 16:45:32 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 16:45:32 INFO - building 'psutil._psutil_posix' extension 16:45:32 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 16:45:32 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 16:45:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:45:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:45:32 INFO - Successfully installed psutil 16:45:32 INFO - Cleaning up... 16:45:33 INFO - Return code: 0 16:45:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:33 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 0x7f7d47c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1991160>, '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 0x1992060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19924f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', '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 16:45:33 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 16:45:33 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 16:45:33 INFO - Using env: {'DISPLAY': ':0', 16:45:33 INFO - 'HOME': '/home/cltbld', 16:45:33 INFO - 'LANG': 'en_US.UTF-8', 16:45:33 INFO - 'LANGUAGE': 'en_US:en', 16:45:33 INFO - 'LOGNAME': 'cltbld', 16:45:33 INFO - 'MAIL': '/var/mail/cltbld', 16:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:33 INFO - 'MOZ_NO_REMOTE': '1', 16:45:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:33 INFO - 'NO_EM_RESTART': '1', 16:45:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:33 INFO - 'PWD': '/builds/slave/test', 16:45:33 INFO - 'SHELL': '/bin/bash', 16:45:33 INFO - 'SHLVL': '1', 16:45:33 INFO - 'TERM': 'linux', 16:45:33 INFO - 'TMOUT': '86400', 16:45:33 INFO - 'USER': 'cltbld', 16:45:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', 16:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:33 INFO - '_': '/tools/buildbot/bin/python'} 16:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:45:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:45:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:45:35 INFO - Installing collected packages: mozsystemmonitor 16:45:35 INFO - Running setup.py install for mozsystemmonitor 16:45:35 INFO - Successfully installed mozsystemmonitor 16:45:35 INFO - Cleaning up... 16:45:35 INFO - Return code: 0 16:45:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:35 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 0x7f7d47c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1991160>, '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 0x1992060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19924f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', '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 16:45:35 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 16:45:35 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 16:45:35 INFO - Using env: {'DISPLAY': ':0', 16:45:35 INFO - 'HOME': '/home/cltbld', 16:45:35 INFO - 'LANG': 'en_US.UTF-8', 16:45:35 INFO - 'LANGUAGE': 'en_US:en', 16:45:35 INFO - 'LOGNAME': 'cltbld', 16:45:35 INFO - 'MAIL': '/var/mail/cltbld', 16:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:35 INFO - 'MOZ_NO_REMOTE': '1', 16:45:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:35 INFO - 'NO_EM_RESTART': '1', 16:45:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:35 INFO - 'PWD': '/builds/slave/test', 16:45:35 INFO - 'SHELL': '/bin/bash', 16:45:35 INFO - 'SHLVL': '1', 16:45:35 INFO - 'TERM': 'linux', 16:45:35 INFO - 'TMOUT': '86400', 16:45:35 INFO - 'USER': 'cltbld', 16:45:35 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', 16:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:35 INFO - '_': '/tools/buildbot/bin/python'} 16:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:35 INFO - Downloading/unpacking blobuploader==1.2.4 16:45:35 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 16:45:35 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 16:45:35 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 16:45:35 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 16:45:35 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 16:45:35 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 16:45:37 INFO - Downloading blobuploader-1.2.4.tar.gz 16:45:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:45:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:45:37 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 16:45:37 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 16:45:37 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 16:45:37 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 16:45:37 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 16:45:37 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 16:45:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:45:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:45:37 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 16:45:37 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 16:45:37 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 16:45:37 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 16:45:37 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 16:45:37 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 16:45:38 INFO - Downloading docopt-0.6.1.tar.gz 16:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:45:38 INFO - Installing collected packages: blobuploader, requests, docopt 16:45:38 INFO - Running setup.py install for blobuploader 16:45:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:45:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:45:38 INFO - Running setup.py install for requests 16:45:38 INFO - Running setup.py install for docopt 16:45:38 INFO - Successfully installed blobuploader requests docopt 16:45:38 INFO - Cleaning up... 16:45:38 INFO - Return code: 0 16:45:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:38 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 0x7f7d47c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1991160>, '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 0x1992060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19924f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', '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 16:45:38 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 16:45:38 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 16:45:38 INFO - Using env: {'DISPLAY': ':0', 16:45:38 INFO - 'HOME': '/home/cltbld', 16:45:38 INFO - 'LANG': 'en_US.UTF-8', 16:45:38 INFO - 'LANGUAGE': 'en_US:en', 16:45:38 INFO - 'LOGNAME': 'cltbld', 16:45:38 INFO - 'MAIL': '/var/mail/cltbld', 16:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:38 INFO - 'MOZ_NO_REMOTE': '1', 16:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:38 INFO - 'NO_EM_RESTART': '1', 16:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:38 INFO - 'PWD': '/builds/slave/test', 16:45:38 INFO - 'SHELL': '/bin/bash', 16:45:38 INFO - 'SHLVL': '1', 16:45:38 INFO - 'TERM': 'linux', 16:45:38 INFO - 'TMOUT': '86400', 16:45:38 INFO - 'USER': 'cltbld', 16:45:38 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', 16:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:38 INFO - '_': '/tools/buildbot/bin/python'} 16:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:45:39 INFO - Running setup.py (path:/tmp/pip-SMqYfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:45:39 INFO - Running setup.py (path:/tmp/pip-6l3WQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:45:39 INFO - Running setup.py (path:/tmp/pip-cMmaAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:45:39 INFO - Running setup.py (path:/tmp/pip-S_Gz9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:45:39 INFO - Running setup.py (path:/tmp/pip-TQS_58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:45:39 INFO - Running setup.py (path:/tmp/pip-TNWp8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:45:39 INFO - Running setup.py (path:/tmp/pip-vxNaP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:45:39 INFO - Running setup.py (path:/tmp/pip-KlStvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:45:39 INFO - Running setup.py (path:/tmp/pip-zRLSnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:45:39 INFO - Running setup.py (path:/tmp/pip-iKTjHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:45:39 INFO - Running setup.py (path:/tmp/pip-ghb_PW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:45:39 INFO - Running setup.py (path:/tmp/pip-rqmLyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:45:39 INFO - Running setup.py (path:/tmp/pip-wCmF1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:45:39 INFO - Running setup.py (path:/tmp/pip-PTatEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:40 INFO - Running setup.py (path:/tmp/pip-Xz54_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:45:40 INFO - Running setup.py (path:/tmp/pip-fQu4CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:45:40 INFO - Running setup.py (path:/tmp/pip-05Xw9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:45:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:45:40 INFO - Running setup.py install for manifestparser 16:45:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:45:40 INFO - Running setup.py install for mozcrash 16:45:40 INFO - Running setup.py install for mozdebug 16:45:40 INFO - Running setup.py install for mozdevice 16:45:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:45:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:45:40 INFO - Running setup.py install for mozfile 16:45:40 INFO - Running setup.py install for mozhttpd 16:45:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:45:40 INFO - Running setup.py install for mozinfo 16:45:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:45:40 INFO - Running setup.py install for mozInstall 16:45:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:45:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:45:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:45:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:45:41 INFO - Running setup.py install for mozleak 16:45:41 INFO - Running setup.py install for mozlog 16:45:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:45:41 INFO - Running setup.py install for moznetwork 16:45:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:45:41 INFO - Running setup.py install for mozprocess 16:45:41 INFO - Running setup.py install for mozprofile 16:45:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:45:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:45:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:45:41 INFO - Running setup.py install for mozrunner 16:45:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:45:41 INFO - Running setup.py install for mozscreenshot 16:45:41 INFO - Running setup.py install for moztest 16:45:41 INFO - Running setup.py install for mozversion 16:45:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:45:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:45:42 INFO - Cleaning up... 16:45:42 INFO - Return code: 0 16:45:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:42 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 0x7f7d47c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1991160>, '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 0x1992060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19924f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', '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 16:45:42 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 16:45:42 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 16:45:42 INFO - Using env: {'DISPLAY': ':0', 16:45:42 INFO - 'HOME': '/home/cltbld', 16:45:42 INFO - 'LANG': 'en_US.UTF-8', 16:45:42 INFO - 'LANGUAGE': 'en_US:en', 16:45:42 INFO - 'LOGNAME': 'cltbld', 16:45:42 INFO - 'MAIL': '/var/mail/cltbld', 16:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:42 INFO - 'MOZ_NO_REMOTE': '1', 16:45:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:42 INFO - 'NO_EM_RESTART': '1', 16:45:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:42 INFO - 'PWD': '/builds/slave/test', 16:45:42 INFO - 'SHELL': '/bin/bash', 16:45:42 INFO - 'SHLVL': '1', 16:45:42 INFO - 'TERM': 'linux', 16:45:42 INFO - 'TMOUT': '86400', 16:45:42 INFO - 'USER': 'cltbld', 16:45:42 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', 16:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:42 INFO - '_': '/tools/buildbot/bin/python'} 16:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:45:42 INFO - Running setup.py (path:/tmp/pip-38DF5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:45:42 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)) 16:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:45:42 INFO - Running setup.py (path:/tmp/pip-PevbZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:45:42 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)) 16:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:45:42 INFO - Running setup.py (path:/tmp/pip-vIeTlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:45:42 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)) 16:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:45:42 INFO - Running setup.py (path:/tmp/pip-fDhYCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:45:42 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)) 16:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:45:42 INFO - Running setup.py (path:/tmp/pip-kULu9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:45:42 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)) 16:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:45:42 INFO - Running setup.py (path:/tmp/pip-WO7Npg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:45:42 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)) 16:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:45:42 INFO - Running setup.py (path:/tmp/pip-OMfe8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:45:42 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)) 16:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:45:42 INFO - Running setup.py (path:/tmp/pip-1XrNet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:45:42 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)) 16:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:45:42 INFO - Running setup.py (path:/tmp/pip-8OdwZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:45:42 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)) 16:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:45:42 INFO - Running setup.py (path:/tmp/pip-kRarbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:45:42 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)) 16:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:45:42 INFO - Running setup.py (path:/tmp/pip-PIHXK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:45:43 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)) 16:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:45:43 INFO - Running setup.py (path:/tmp/pip-9WvxtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:45:43 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)) 16:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:45:43 INFO - Running setup.py (path:/tmp/pip-ZWKz5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:45:43 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)) 16:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:45:43 INFO - Running setup.py (path:/tmp/pip-EHDn_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:45:43 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)) 16:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:43 INFO - Running setup.py (path:/tmp/pip-rdP1CU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:43 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)) 16:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:45:43 INFO - Running setup.py (path:/tmp/pip-flQbuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:45:43 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)) 16:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:45:43 INFO - Running setup.py (path:/tmp/pip-N8aolh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:45:43 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)) 16:45:43 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)) 16:45:43 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)) 16:45:43 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)) 16:45:43 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)) 16:45:43 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)) 16:45:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45:45 INFO - Downloading blessings-1.6.tar.gz 16:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:45:45 INFO - Installing collected packages: blessings 16:45:45 INFO - Running setup.py install for blessings 16:45:45 INFO - Successfully installed blessings 16:45:45 INFO - Cleaning up... 16:45:45 INFO - Return code: 0 16:45:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:45:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:45:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:45:45 INFO - Reading from file tmpfile_stdout 16:45:45 INFO - Current package versions: 16:45:45 INFO - argparse == 1.2.1 16:45:45 INFO - blessings == 1.6 16:45:45 INFO - blobuploader == 1.2.4 16:45:45 INFO - docopt == 0.6.1 16:45:45 INFO - manifestparser == 1.1 16:45:45 INFO - mozInstall == 1.12 16:45:45 INFO - mozcrash == 0.17 16:45:45 INFO - mozdebug == 0.1 16:45:45 INFO - mozdevice == 0.48 16:45:45 INFO - mozfile == 1.2 16:45:45 INFO - mozhttpd == 0.7 16:45:45 INFO - mozinfo == 0.9 16:45:45 INFO - mozleak == 0.1 16:45:45 INFO - mozlog == 3.1 16:45:45 INFO - moznetwork == 0.27 16:45:45 INFO - mozprocess == 0.22 16:45:45 INFO - mozprofile == 0.28 16:45:45 INFO - mozrunner == 6.11 16:45:45 INFO - mozscreenshot == 0.1 16:45:45 INFO - mozsystemmonitor == 0.0 16:45:45 INFO - moztest == 0.7 16:45:45 INFO - mozversion == 1.4 16:45:45 INFO - psutil == 3.1.1 16:45:45 INFO - requests == 1.2.3 16:45:45 INFO - wsgiref == 0.1.2 16:45:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:45 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 0x7f7d47c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1991160>, '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 0x1992060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19924f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', '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 16:45:45 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 16:45:45 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 16:45:45 INFO - Using env: {'DISPLAY': ':0', 16:45:45 INFO - 'HOME': '/home/cltbld', 16:45:45 INFO - 'LANG': 'en_US.UTF-8', 16:45:45 INFO - 'LANGUAGE': 'en_US:en', 16:45:45 INFO - 'LOGNAME': 'cltbld', 16:45:45 INFO - 'MAIL': '/var/mail/cltbld', 16:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:45 INFO - 'MOZ_NO_REMOTE': '1', 16:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:45 INFO - 'NO_EM_RESTART': '1', 16:45:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:45 INFO - 'PWD': '/builds/slave/test', 16:45:45 INFO - 'SHELL': '/bin/bash', 16:45:45 INFO - 'SHLVL': '1', 16:45:45 INFO - 'TERM': 'linux', 16:45:45 INFO - 'TMOUT': '86400', 16:45:45 INFO - 'USER': 'cltbld', 16:45:45 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', 16:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:45 INFO - '_': '/tools/buildbot/bin/python'} 16:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:46 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)) 16:45:46 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)) 16:45:46 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)) 16:45:46 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)) 16:45:46 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)) 16:45:46 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)) 16:45:46 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)) 16:45:46 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)) 16:45:46 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)) 16:45:46 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)) 16:45:46 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)) 16:45:46 INFO - Cleaning up... 16:45:46 INFO - Return code: 0 16:45:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:46 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 0x7f7d47c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1991160>, '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 0x1992060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19924f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', '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 16:45:46 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 16:45:46 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 16:45:46 INFO - Using env: {'DISPLAY': ':0', 16:45:46 INFO - 'HOME': '/home/cltbld', 16:45:46 INFO - 'LANG': 'en_US.UTF-8', 16:45:46 INFO - 'LANGUAGE': 'en_US:en', 16:45:46 INFO - 'LOGNAME': 'cltbld', 16:45:46 INFO - 'MAIL': '/var/mail/cltbld', 16:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:46 INFO - 'MOZ_NO_REMOTE': '1', 16:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:46 INFO - 'NO_EM_RESTART': '1', 16:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:46 INFO - 'PWD': '/builds/slave/test', 16:45:46 INFO - 'SHELL': '/bin/bash', 16:45:46 INFO - 'SHLVL': '1', 16:45:46 INFO - 'TERM': 'linux', 16:45:46 INFO - 'TMOUT': '86400', 16:45:46 INFO - 'USER': 'cltbld', 16:45:46 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', 16:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:46 INFO - '_': '/tools/buildbot/bin/python'} 16:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:46 INFO - Downloading/unpacking jsonschema 16:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:45:48 INFO - Downloading/unpacking functools32 (from jsonschema) 16:45:48 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 16:45:48 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 16:45:48 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 16:45:48 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 16:45:48 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 16:45:48 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 16:45:48 INFO - Downloading functools32-3.2.3-2.tar.gz 16:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:45:48 INFO - warning: no files found matching '*.txt' 16:45:48 INFO - no previously-included directories found matching 'build' 16:45:48 INFO - no previously-included directories found matching 'dist' 16:45:48 INFO - no previously-included directories found matching '.git*' 16:45:48 INFO - Installing collected packages: jsonschema, functools32 16:45:48 INFO - Running setup.py install for functools32 16:45:48 INFO - warning: no files found matching '*.txt' 16:45:48 INFO - no previously-included directories found matching 'build' 16:45:48 INFO - no previously-included directories found matching 'dist' 16:45:48 INFO - no previously-included directories found matching '.git*' 16:45:48 INFO - Successfully installed jsonschema functools32 16:45:48 INFO - Cleaning up... 16:45:48 INFO - Return code: 0 16:45:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:45:48 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')]} 16:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:48 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')]} 16:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:48 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 0x7f7d47c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1902410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1991160>, '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 0x1992060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19924f0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', '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 16:45:48 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 16:45:48 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 16:45:48 INFO - Using env: {'DISPLAY': ':0', 16:45:48 INFO - 'HOME': '/home/cltbld', 16:45:48 INFO - 'LANG': 'en_US.UTF-8', 16:45:48 INFO - 'LANGUAGE': 'en_US:en', 16:45:48 INFO - 'LOGNAME': 'cltbld', 16:45:48 INFO - 'MAIL': '/var/mail/cltbld', 16:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:48 INFO - 'MOZ_NO_REMOTE': '1', 16:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:48 INFO - 'NO_EM_RESTART': '1', 16:45:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:48 INFO - 'PWD': '/builds/slave/test', 16:45:48 INFO - 'SHELL': '/bin/bash', 16:45:48 INFO - 'SHLVL': '1', 16:45:48 INFO - 'TERM': 'linux', 16:45:48 INFO - 'TMOUT': '86400', 16:45:48 INFO - 'USER': 'cltbld', 16:45:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', 16:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:48 INFO - '_': '/tools/buildbot/bin/python'} 16:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:48 INFO - Downloading/unpacking flake8 16:45:48 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 16:45:48 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 16:45:48 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 16:45:48 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 16:45:48 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 16:45:48 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 16:45:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:45:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:45:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:45:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:45:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:45:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:45:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:45:51 INFO - no previously-included directories found matching 'docs/_build' 16:45:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:45:51 INFO - Running setup.py install for pep8 16:45:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:45:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:45:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:45:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:45:51 INFO - no previously-included directories found matching 'docs/_build' 16:45:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:45:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:45:51 INFO - Cleaning up... 16:45:51 INFO - Return code: 0 16:45:51 INFO - Running post-action listener: _resource_record_post_action 16:45:51 INFO - Running post-action listener: _start_resource_monitoring 16:45:51 INFO - Starting resource monitoring. 16:45:51 INFO - ##### 16:45:51 INFO - ##### Running install step. 16:45:51 INFO - ##### 16:45:51 INFO - Running pre-action listener: _resource_record_pre_action 16:45:51 INFO - Running main action method: install 16:45:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:45:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:45:51 INFO - Reading from file tmpfile_stdout 16:45:51 INFO - Detecting whether we're running mozinstall >=1.0... 16:45:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:45:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:45:52 INFO - Reading from file tmpfile_stdout 16:45:52 INFO - Output received: 16:45:52 INFO - Usage: mozinstall [options] installer 16:45:52 INFO - Options: 16:45:52 INFO - -h, --help show this help message and exit 16:45:52 INFO - -d DEST, --destination=DEST 16:45:52 INFO - Directory to install application into. [default: 16:45:52 INFO - "/builds/slave/test"] 16:45:52 INFO - --app=APP Application being installed. [default: firefox] 16:45:52 INFO - mkdir: /builds/slave/test/build/application 16:45:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:46:04 INFO - Reading from file tmpfile_stdout 16:46:04 INFO - Output received: 16:46:04 INFO - /builds/slave/test/build/application/firefox/firefox 16:46:04 INFO - Running post-action listener: _resource_record_post_action 16:46:04 INFO - ##### 16:46:04 INFO - ##### Running run-tests step. 16:46:04 INFO - ##### 16:46:04 INFO - Running pre-action listener: _resource_record_pre_action 16:46:04 INFO - Running main action method: run_tests 16:46:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:46:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:46:04 INFO - Python 2.7.3 16:46:04 INFO - Return code: 0 16:46:04 INFO - grabbing minidump binary from tooltool 16:46:04 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')]} 16:46:04 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 0x1991160>, '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 0x1992060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19924f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:46:04 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 16:46:04 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 16:46:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:46:04 INFO - Return code: 0 16:46:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:46:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:46:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:46:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:46:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:46:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:46:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:46:05 INFO - Return code: 0 16:46:05 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/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 16:46:05 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/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 16:46:05 INFO - Using env: {'DISPLAY': ':0', 16:46:05 INFO - 'HOME': '/home/cltbld', 16:46:05 INFO - 'LANG': 'en_US.UTF-8', 16:46:05 INFO - 'LANGUAGE': 'en_US:en', 16:46:05 INFO - 'LOGNAME': 'cltbld', 16:46:05 INFO - 'MAIL': '/var/mail/cltbld', 16:46:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:46:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:05 INFO - 'MOZ_NO_REMOTE': '1', 16:46:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:05 INFO - 'NO_EM_RESTART': '1', 16:46:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:05 INFO - 'PWD': '/builds/slave/test', 16:46:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:46:05 INFO - 'SHELL': '/bin/bash', 16:46:05 INFO - 'SHLVL': '1', 16:46:05 INFO - 'TERM': 'linux', 16:46:05 INFO - 'TMOUT': '86400', 16:46:05 INFO - 'USER': 'cltbld', 16:46:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757', 16:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:05 INFO - '_': '/tools/buildbot/bin/python'} 16:46:05 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/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 16:46:06 INFO - mozversion application_buildid: 20160602140837 16:46:06 INFO - mozversion application_changeset: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea 16:46:06 INFO - mozversion application_display_name: Firefox 16:46:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:46:06 INFO - mozversion application_name: Firefox 16:46:06 INFO - mozversion application_remotingname: firefox 16:46:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:46:06 INFO - mozversion application_vendor: Mozilla 16:46:06 INFO - mozversion application_version: 47.0 16:46:06 INFO - mozversion platform_buildid: 20160602140837 16:46:06 INFO - mozversion platform_changeset: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea 16:46:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:46:06 INFO - mozversion platform_version: 47.0 16:46:06 INFO - using testdate: 1464911166 16:46:06 INFO - actual date: 1464911166 16:46:06 INFO - starting webserver on 'localhost:48795' 16:46:06 INFO - SUITE-START | Running 2 tests 16:46:06 INFO - TEST-START | dromaeo_css 16:46:06 INFO - operating with platform_type : linux_ 16:46:06 INFO - Initialising browser for dromaeo_css test... 16:46:06 INFO - TEST-INFO | started process 4265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXL2G1U/profile http://localhost:48795/getInfo.html) 16:46:09 INFO - PROCESS | 4265 | 16:46:09 INFO - PROCESS | 4265 | (process:4344): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:46:10 INFO - PROCESS | 4265 | __metrics Screen width/height:1600/1200 16:46:10 INFO - PROCESS | 4265 | colorDepth:24 16:46:10 INFO - PROCESS | 4265 | Browser inner width/height: 1024/697 16:46:10 INFO - PROCESS | 4265 | __metrics 16:46:11 ERROR - PROCESS | 4265 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 16:46:12 INFO - TEST-INFO | 4265: exit 0 16:46:12 INFO - Browser initialized. 16:46:12 INFO - Running cycle 1/1 for dromaeo_css test... 16:46:12 INFO - TEST-INFO | started process 4394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXL2G1U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:46:14 INFO - PROCESS | 4394 | 16:46:14 INFO - PROCESS | 4394 | (process:4460): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:46:24 INFO - PROCESS | 4394 | RSS: Main: 149827584 16:46:24 INFO - PROCESS | 4394 | 16:47:13 INFO - PROCESS | 4394 | 1464911233750 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] 16:49:21 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:48795/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48795/tests/dromaeo/cssquery-ext.html) 16:49:22 INFO - PROCESS | 4394 | RSS: Main: 153427968 16:49:22 INFO - PROCESS | 4394 | 16:52:24 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:48795/tests/dromaeo/cssquery-ext.html (next: http://localhost:48795/tests/dromaeo/cssquery-jquery.html) 16:52:25 INFO - PROCESS | 4394 | RSS: Main: 152707072 16:52:25 INFO - PROCESS | 4394 | 16:55:26 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:48795/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48795/tests/dromaeo/cssquery-mootools.html) 16:55:27 INFO - PROCESS | 4394 | RSS: Main: 151703552 16:55:27 INFO - PROCESS | 4394 | 16:58:29 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:48795/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48795/tests/dromaeo/cssquery-prototype.html) 16:58:29 INFO - PROCESS | 4394 | RSS: Main: 152674304 16:58:29 INFO - PROCESS | 4394 | 17:01:32 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:48795/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48795/tests/dromaeo/cssquery-yui.html) 17:01:32 INFO - PROCESS | 4394 | RSS: Main: 151027712 17:01:32 INFO - PROCESS | 4394 | 17:04:34 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:48795/tests/dromaeo/cssquery-yui.html (next: http://localhost:48795/tests/dromaeo/cssquery-dojo.html) 17:04:34 INFO - PROCESS | 4394 | RSS: Main: 155795456 17:04:34 INFO - PROCESS | 4394 | 17:04:34 INFO - PROCESS | 4394 | __start_tp_report 17:04:34 INFO - PROCESS | 4394 | _x_x_mozilla_page_load 17:04:34 INFO - PROCESS | 4394 | _x_x_mozilla_page_load_details 17:04:34 INFO - PROCESS | 4394 | |i|pagename|runs| 17:04:34 INFO - PROCESS | 4394 | |0;dojo.html;3335.7831740936836;3415.5218269442285;3416.4533674612035;3447.6897079262862;3465.116395319195;5507.256520369749;5553.888922221553;5556.749946252418;5558.666480011202;5629.437056294369;5608.270924779783;5612.017896868052;5634.577406694504;5636.605437619368;5637.774489020445;5086.898262034757;5173.094708426029;5178.0679477694;5212.374515058198;5235.293235413209;4994.97502512487;5117.181250999841;5210.661307015051;5212.6611770235;5252.107141785887;5144.768485418165;5151.098557752397;5187.092258854705;5206.062908676437;5257.263983042377;5138.126518491866;5149.742512874342;5162.199859021857;5164.535191832753;5191.532762051395;4962.851114466572;4973.403191617029;5100.591952643779;5123.590112790967;5141.203113517411;5427.158790387496;5440.972795136038;5481.12302031677;5487.396386397493;5505.229267902497;6020.5785595008365;6035.245594300713;6080.787172448987;6085.208922840003;6085.878282434326;5896.056630939072;5978.372270911535;6033;6056.152138700585;6080.878382432371;5664.631798933056;5682.573806964453;5684.7157642118145;5686.402927692574;5690.601657883991;6053.697315134225;6175.783847565313;6185.907211391833;6190.133381326618;6191.380861913773;5907.409259074058;5967.492763115097;5983.431574000463;5984.730687119003;6002.0996850472775;6079.756809727562;6089.695515224221;6090.908636370458;6092.329843717188;6117.143599896018;5785.450382213683;5964.642121472725;6010.3689112643415;6018.518518518508;6035.637861728311;5930.644161350333;5961;5978.850528736816;5995.370486098984;6017.308009578955;4518.932216016762;4530.954690453119;4535.047639995571;4552.408186935677;4559.908801824011;3998.5801490843623;4030.8186131624147;4093.570175131628;4114.814833332507;4166.208420400114;5546.611737178439;5684.971575142098;5708.71456427177;5742.511886489611;5811.895739809423;6035.336113027563;6039.516838652898;6107.755689772448;6111.694415279218;6115.388461153938;5527;5709.229254050733;5771.538276937835;5776.624519406225;5776.884462310731;5084.491550844886;5101.566366858784;5110.3356563646485;5148.9742551287;5150.330457040635;6079.574429789872;6194.473469755121;6198.690065496708;6199.56603037783;6204.658743769046;5781.797637082682;5997.820065398045;6000.909986350295;6003.069524223665;6068.029115341524;6265.96867015662;6313.179286692701;6337.556371053982;6342.048692695948;6342.270638876588;5985.820425387245;6040.909386359121;6056.545759068175;6058.787942421994;6062.514998799998;5858.414158584107;5955.076963070731;6019.608725432833;6072.392760724069;6087.117367981707;5789.884202316014;5790.768369265183;5809.82570522885;5814.94185058144;5833.620814647034;5766.740496677576;5818.272715910512;5821.27234095738;5825.271841019872;5833.620814647034;5701.600887937804;5775.48020678141;5814.76740930358;5868.295804503487;5888.646681199141;5938.257717785277;5948.256467941507;5972.940270597239;5984.521238301013;6014.9097763534455;5698.686572238566;5821.7089145543405;5870.383609721089;5880.529557635465;5891.528677705859 17:04:34 INFO - PROCESS | 4394 | |1;ext.html;495.87107352088447;547.6166683321675;550.8402563256656;556.3018411893073;565.7312776431196;37720.622793772054;38327.233455330876;38342.04144896383;38423.039424014416;38504.422433663516;42774.14451710964;43296.783516082454;43359.34960975588;43453.565464345425;43643.78178109113;8685.782855428633;8951.104889511029;8972.910270897306;9014.954925225366;9016.233620142295;8809.119088091204;8925.95537022314;8952.283817294634;9178.265738740918;9300.20948219402;9171.908280917172;9275.257979361635;9275.39709918853;9280.907190928072;9282.396644218104;9164.816703665923;9228.815423691522;9237.907620923772;9242.12199841014;9247.768805779842;8989.415687980325;9131.77170570741;9163.908360916439;9167.358284920057;9176.632934682604;42875.35686964667;43369.56630433687;43376.3493547597;43447.56552434467;43479;3412.146963259185;3432.1076520104702;3494.5457090578316;3516.753827232095;3741.906452338686;30058.24854378636;31108.533371999438;31520.211994700087;31562.842185788923;31761.841190793897;3301.950470742941;3436.037909385376;3451.5858097028517;3506.9298614027575;3524.665156810099;311586;314718;317669;320161;320170;49118.75440622774;50030;68546;69047;69339;44193.77903110464;44249.55750442519;44269.11461770811;44456;44518.777406112764;17983.550411239823;18342.724859127124;18372;18394.080295985146;18443.538911527317;14507.202103884387;14618.634534136732;14636.487722929647;14641.92679036598;14644;15707.764383534257;15722.528324150293;15771.447999320199;15795.289211985488;15847.207639617973;5900.616459930091;6019.60872543292;6032.698365081728;6073.362296958844;6113.602615829956;1067.114295135036;1069.8288273876142;1080.989190108089;1099.4008265495324;1128.1989787251143;29858.253543661584;29894.701052989625;30363.392732145232;30715.38569228603;30951.69048309533;1114.5876025870318;1129.7627498225465;1198.9160758746978;1222.2255480060214;1223.687959570304;15446.768298475532;15535.766963495556;15694.76457853133;15766.527004189893;15922.203889805694;340138;833665;849166;849545;857678;61846.69076654678;62163;62425;62528;62832.68583657053;1454.1638557829501;1462.159258426409;1491.9850801491846;1497.7154340675236;1536.4622382166376;31351.686483134876;31808;32293.677063230007;32357.51463727999;32732.50901236531;50703;50900.490995089574;51327.230091547906;51516.48483515117;51677.48322516727;312402;318399;318761;319237;320941;35093.29813403769;35199.12002199965;35251.294974100885;35445.82277088598;35580;47564.762176190285;47639;47865;47897.76051119722;47951.28073078977;38999;39052.41421378625;39156;39992.80003599964;40035.1992960145;38874.80562597282;39521;40237.798811005756;40585.404574094304;41144.588554114074;39042.609573903894;39682.603173969044;40375.59624403718;40391;40413.79793101016;35098;35399.64600354066;35678.821605892845;35697.72003794135;36172.81913590415;26350.341241469116;27371.31571710723;27525.44949101047;27540.58689119705;27750.167494975183 17:04:34 INFO - PROCESS | 4394 | |2;jquery.html;370.34818719054454;372.25920418367457;372.96083911189334;380.40656575741843;383.45932235547883;18353.632927341445;18414.447566573006;19390.903045484753;19569.217231310766;19588.216471341166;18702.251909923587;19076.90461547694;19121.23515059396;19196.136173872175;19263.807361926378;5545.890821835639;5835.708214589275;5842.620229685057;5842.766289348442;5843.18195452637;5581.190727344532;5732.369439361667;5778.104393818965;5826.708664566776;5828.883422331551;5715.514181294574;5716.857078573048;5721.713914304289;5729.026065568843;5744.712764361786;5474.452554744534;5668.716564171796;5682.147677848315;5689.345725241609;5701.57238207134;5102.974485127587;5119.257707632372;5119.795208191668;5128.025675121715;5128.1282182029145;21462.034208460656;21780.237691680715;22193.77806221933;22527.549449010927;22563.097476100935;2424.175780234729;2521.735217802123;2573.6010918307693;2893.14652177606;3183.442897492953;13573.932130339284;13937.09408888419;14386.136831790127;14423.423063077464;14601.853981460155;1943.2227109156308;1990.4028791362678;1991.2134706790882;2021.191523390641;2065.10168076887;64541;64583.3541664582;65591.344086559;66968.33031669719;67367.32632673708;9781.951090244645;9800.460974646463;10148.137408320228;10566;10868.239223254455;14717.043392179474;14835.777463338058;14835.851641483447;14841.332140053724;14861.851381486047;8373.539455329894;8511.319094472427;8609.182127697859;8692.695755648521;8707.390482666153;8696.95651521751;8818.426802257833;8825.91174088251;8889.244414224733;8909.821803564022;6107.938920610826;6114.174586430775;6182.381761823782;6191.19514463126;6280.403361680633;1785.7321401789575;1796.5059608607476;1813.1206364913007;1824.087956021989;1828.8994105324068;1022.3150489172273;1047.3297089862494;1123.9269447486051;1150.8676502202186;1176.335370515656;17510.474685759447;17649.117544123;17897.105144742713;17980.820191798175;18406.26374945014;998.9450580218013;999.5252255178732;1024.6874703215442;1033.9896601033893;1062.2564205056492;9261.259099272042;10893.074088702391;10937.507812148473;10953.397563133945;10967.890321096687;431979;432357;447183;449716;457535;69600.65199674071;70256.29743702599;70317;72416;73438;1080.897314755097;1081.9188560857967;1091.879893211746;1095.895889890459;1110.9277896936674;16291.185440727679;16393.83606163923;16527.83472165263;16610.335586576402;16682.16589170561;33340.166495837795;33724.662753372155;34137.31725365528;34764.65235347614;35143.94568162959;45470;45954.770226149994;46120.53879461296;46422.071558567965;46459.767701161276;8529.104444033288;8549.487030778173;8575.3997220194;8718.956405217934;8846.424982376126;11882.346470943836;12755.107142499935;12794.14484899703;12906.967442604382;13126.60620181396;10366.170706343626;10375.273730839072;10416.791664166825;10630.30902991303;11133.610323638633;10258.794824103625;10373.792524149625;10465;10521.421321827373;11549;11694.941525292319;12128.272303661808;12277;12435.875641243834;12438.751224975631;8325.708600198965;8411.915880841114;8476;8540.14598540141;8645.91354086451;11682.123840712151;12236.938815305866;12256;12263.448144833683;12316.13787034899 17:04:34 INFO - PROCESS | 4394 | |3;mootools.html;1540.0451719933642;1585.151943710115;1815.718563622639;1890.7636545431822;1950.5318723506355;7494.325510704036;8004.4797088189225;8157.877631835512;8267.379946504014;8270.131636178205;8277.296429803459;8308.418410711252;8344.08215096339;8426.199511046456;8445.49327040378;2425.539147561962;2458.4714286428416;2470.8270421070533;2471.369800700828;2472.7032756069298;2212.5353675728115;2244.2257421189665;2248.820094392453;2248.8425810193294;2251.8761468119246;2373.9406514837096;2379.9048038078454;2411.4815314707334;2437.3297343230574;2451.6322551617222;2388.940276493084;2405.025964484387;2407.735149133594;2411.1801987324307;2419.9637005444756;2370.3007612754277;2375.239923224569;2398;2408.710954685449;2409.8795060246916;8490.53302068386;8527.360447966428;8548.658053677846;8570.528620925847;8576;5130.53825155734;5268.473152684739;5271.446498117681;5273.31446911899;5274.604404669665;3150.3384289299274;3173.0480855743185;3206.64726880043;3250.6586808385014;3286.194882253863;948.184561277301;969.8933117357085;982.0670363155032;994.1152374386802;1019.1642852860657;12094.939525302405;12098.87901120995;12123.575674851338;12126.211796233216;12139.393030348447;4541.84103556374;4543.454785425704;4612.953870461252;4638.257878739386;4679.883002924954;10218.437985910698;10253.025962533547;10282.537285822156;10285.228607854291;10328.328658637165;5272.92090618641;5281.0758117329315;5340.172273297645;5354.303940487712;5361.51746342831;4660.510646382081;4790.664653474293;4835.395575553056;4836.564709176191;4839.395075615548;3638.1086633774366;3716.21959388526;3739.7382183247455;3739.9252014959548;3790.29879472293;1099.8845121262311;1117.921745477825;1118.888111188891;1127.3517727306833;1128.6726849213635;1434.619825746178;1448.5147475595793;1453.382312517176;1463.370750577262;1473.4474572035488;8067.273945344947;8129.593520323961;8141.470804397695;8156.510609363457;8188.877166842502;527.30659183174;527.3724268120924;530.0485628297216;531.1183435497056;538.4238864415038;6006.489448396847;6037.275526936795;6038.18484504595;6105.419985101408;6152.077188421683;10249.641262555775;10662.840057399146;10691.946540267249;10700.501929729844;10827.891721082846;9552;10380.117689996436;10467.84298235527;10493.26547141708;10598.788024239626;7773.883391749128;7865.724699635485;7872.881906771403;7889.960550197212;7909;7639.121501027453;7661.540307581563;7703.383729301754;7773.144954055162;7805.258500442676;8698.60856261457;9004.41471304363;9011.324150688855;9058.954705226695;9092.318076144447;8997.865032024656;9083.863742044006;9109.77225569366;9231.76920576991;9251.121143491358;7002.719891204295;7759.3404560610725;8004.679812807422;8169.223923727236;8325.916740832514;8111.472754270953;8135.064467586067;8141.592920354077;8168.754937351889;8178.223068808454;7141.071660684078;7167.784966451015;7195.928040719526;7220.819479513054;7479.027726395534;7198.71205151788;7216.3505284524645;7277.781666550012;7294.088238970129;7326.96336518314;7308.707651693872;7326.974223608806;7358.448116391185;7369.520981136209;7381.335679788845;6955.721771129098;6963.2340442552295;7013.649317534205;7034.964825175842;7048.788536343918;7085.893711594227;7189.460790440633;7213.639318034182;7216.96391518039;7223.891641625485 17:04:34 INFO - PROCESS | 4394 | |4;prototype.html;344.94998225257336;348.23214811340995;348.6966339284822;349.11673466130696;353.4821486522246;6328.778492752755;6385.999999999988;6393.52048596356;6424.710888010033;6438.551325951665;6297.244330680313;6323.5257355698395;6326.272478664955;6331.841703957403;6345.016522439029;4713.293006049103;4828.082664293773;4842.97578512107;4852.223644216926;4885.999999999991;4819.180739274332;4821.156297647915;4822.686525375857;4844.20070688336;4856.1016212000895;4773.498782627827;4776.570108690217;4784.808607655689;4786.186348320776;4789.760511974405;4789.592884604813;4790.305405716152;4791.257355109963;4797.496262892416;4806.44725856524;4171.165766846643;4175.498940127204;4175.665946724254;4176.227397931362;4178.289690752579;5919.112133180014;6052.54605904559;6094.720108777162;6106.816795496098;6115.663638499881;5606.831795046114;5626.015447296707;5627.7467513961565;5639.633423827479;5644.209810626516;6652.268250492442;6668.566543174727;6679.532432729711;6715.3620406061345;6725.562838415536;4652.488226295105;4654.162250794856;4659.580637742585;4662.603678687316;4672.229082201433;6892.069570607954;6918.308169183092;6925.480588955848;6939.791806245871;6943.72225110995;4521.3896124023495;4589.059242855206;4653.441587009581;4661.627069834405;4665.206914824488;4668.5798278155125;4691.319758634979;4696.459907110726;4718;4726.432828060655;5406.162044883049;5458.344998600193;5461.863453413696;5463.808766693147;5473.124300111963;6659.733610655617;6672.2994085621285;6675.86648267032;6676.53264271506;6684.231313398924;1690.797104347486;1699.600593860442;1699.7110491216522;1700.8129105798353;1701;1081.1620993729923;1103.227740581596;1106.5463160104318;1106.756513567014;1138.925969811976;6493.545451818327;6540.542162048611;6541.934580654132;6567.868642627121;6568.474522038226;6961.895571566431;6965.860682786316;7003.719851205997;7010.123734533184;7036.577805331594;6460.030995350641;6536.673166341759;6618.007298905202;6620.602763834186;6639.3692599203;3812.8284227209842;3852.8844134676006;3853.5183102112237;3853.8843834684444;3860.4595356650093;7297.197308296083;7323.926760732431;7347.448941329421;7350.889736653954;7380.5940673263485;7230.783076507713;7235.746748863765;7243.782686519413;7248.347648711641;7283.672234749449;7161;7348;7389.778306650809;7390.96304518474;7394;7024.473164512579;7038.40173585251;7047.894281585678;7099.893501597583;7105.46708996817;6945.374916257561;6961.199462061725;6967.616781076887;6974.4769142315545;6982.406495447944;7303.634818259172;7328.78013659591;7338.192798792022;7347.66935487915;7383.778486645409;4798.66409351356;4940.654154209171;4947.3073769671555;4984.800607975641;4988.2268248420105;6998.790036298919;7018.649067546704;7031;7033.331833475811;7037.612931288828;6761.256261811099;6764.966175169093;6811.352921472452;6817.181938167451;6826;6768.4585233182215;6783.59298442095;6792.456603471809;6797.864042719217;6811.421029212573;6559.0817285579105;6680.432163266177;6748.763793267212;6752.223494298219;6755.594664320157;6888.276730943179;6916.619585922621;6920.508616898013;6925.445964322943;6935.791926242221;6715.496337774589;6760.01979712929;6760.256371799196;6764.763233287008;6771.492138089565 17:04:34 INFO - PROCESS | 4394 | |5;yui.html;743.1936349061269;758.9279018493248;768.2356055724555;771.4407054885208;797.7566842113157;14524.78212826807;14744.33650485728;14748.70502589949;14751.336189871454;14836.851631483682;14075.859241407583;14079.859201407982;14116.43534258631;14149.292535373215;14198.645033874158;922.483409290796;953.5280036381967;953.7186529973675;954.1889394015067;954.3558098283665;755.7014979083286;926.1248120526105;958.0276019839868;958.832204364237;960.8654788329604;973.8539219117118;979.8677178580907;981.7447463659429;985.4136788610801;985.4333758089092;968.1480297338297;974.1865542272211;976.653288082731;980.4460479828874;983.5524836199547;720.2761224968925;723.0528008309132;724.4711360706661;724.6449239872477;725.3363172696976;14739.705205895822;14762.48331308399;14864.777028344584;14896.776548351783;14953.925230373887;12598.874011259863;12873.935630321788;13088.738225235442;13182.34088295591;13230.536931207362;11161.274517156358;11448.71378215543;11576.42117894102;11634.592789252336;11640.650780476599;3814.809259537012;3829.100161462054;3854.498915141042;3858.9614103858885;3874.2638898609175;52395.214071788956;52707.209391859156;53325.733371333285;53837;53871.92256154894;10438;10444.112250458797;10532.473376331152;10567.365958042543;10601.098906593026;19769.901150494155;19771;19826.801731982785;19838;19894.50263743418;7746.845063098706;7890.053193616803;7898.052233731989;8094.473859199134;8388.916110838814;4485.753283569435;4560.6807523473035;4569.428821397325;4573.153966516205;4592.954070459253;3351.614564325085;3371.190914180579;3372.3929692655065;3372.730181585467;3376.2234686022352;581.8632621333983;597.2832600878876;604.5526310530176;606.8118883146238;614.3089024847047;597.9103134529769;651.1242379000237;691.02565382811;699.867025265198;723.2189235625511;8386.916130838736;8764.91235087641;8806.647734090693;8865.778355541162;8974.910250897537;525.5742848292895;622.2657264427928;642.3171291217042;664.3323459922747;672.5393105722497;3964.484616999829;4067.5322337930925;4094.754314741125;4125.91748165035;4250.192463431938;55474;57218;57314.7134264326;57467.42532574704;57535.71232143813;49864.252036219485;50020.74989625029;50108.24837627439;50115.49884501108;51128.48871511312;43913;44840.55159448364;44871.326930096075;45388.546114539095;46128.308075378896;8172.713955011784;8223.342132629496;8279;8526.190011948855;8577.228049475327;35013;35369.646303537666;36561.63438365582;36565.45151822671;37094.8145259272;40206.59793402028;40271;42089.57910420857;43190.352144717224;43385;10487.475626218811;10511.10655594283;10561;10601.416922069051;10744.62393816244;11532.769344612892;11586.188966772583;11613.5354585819;11675.065994720571;12323.198992065487;11509.366984815915;11748.412579371168;11780.882191178322;11943.641690749291;12094.45574949147;11539.88460115388;11540.134489913458;11727.941360293144;11753.647390578297;12081.879181208076;10631.521581528696;11016;11035.062019728091;11888.108391870472;11902.583409580624;9442.197413219954;9565.330426870052;9871.309008369346;9996.650117245861;10030.398176109456;9475.099865512766;9600.75998100053;9617.893942196737;10085.29402941787;10170.491475426052 17:04:34 INFO - PROCESS | 4394 | __end_tp_report 17:04:34 INFO - PROCESS | 4394 | __start_cc_report 17:04:34 INFO - PROCESS | 4394 | _x_x_mozilla_cycle_collect,329 17:04:34 INFO - PROCESS | 4394 | __end_cc_report 17:04:34 INFO - PROCESS | 4394 | __startTimestamp1464912274921__endTimestamp 17:04:34 INFO - PROCESS | 4394 | 17:04:34 INFO - PROCESS | 4394 | ------- Summary: start ------- 17:04:34 INFO - PROCESS | 4394 | Number of tests: 6 17:04:34 INFO - PROCESS | 4394 | 17:04:34 INFO - PROCESS | 4394 | [#0] dojo.html Cycles:165 Average:5597.09 Median:5809.83 stddev:625.90 (10.8%) stddev-sans-first:602.15 17:04:34 INFO - PROCESS | 4394 | Values: 3335.8 3415.5 3416.5 3447.7 3465.1 5507.3 5553.9 5556.7 5558.7 5629.4 5608.3 5612.0 5634.6 5636.6 5637.8 5086.9 5173.1 5178.1 5212.4 5235.3 4995.0 5117.2 5210.7 5212.7 5252.1 5144.8 5151.1 5187.1 5206.1 5257.3 5138.1 5149.7 5162.2 5164.5 5191.5 4962.9 4973.4 5100.6 5123.6 5141.2 5427.2 5441.0 5481.1 5487.4 5505.2 6020.6 6035.2 6080.8 6085.2 6085.9 5896.1 5978.4 6033.0 6056.2 6080.9 5664.6 5682.6 5684.7 5686.4 5690.6 6053.7 6175.8 6185.9 6190.1 6191.4 5907.4 5967.5 5983.4 5984.7 6002.1 6079.8 6089.7 6090.9 6092.3 6117.1 5785.5 5964.6 6010.4 6018.5 6035.6 5930.6 5961.0 5978.9 5995.4 6017.3 4518.9 4531.0 4535.0 4552.4 4559.9 3998.6 4030.8 4093.6 4114.8 4166.2 5546.6 5685.0 5708.7 5742.5 5811.9 6035.3 6039.5 6107.8 6111.7 6115.4 5527.0 5709.2 5771.5 5776.6 5776.9 5084.5 5101.6 5110.3 5149.0 5150.3 6079.6 6194.5 6198.7 6199.6 6204.7 5781.8 5997.8 6000.9 6003.1 6068.0 6266.0 6313.2 6337.6 6342.0 6342.3 5985.8 6040.9 6056.5 6058.8 6062.5 5858.4 5955.1 6019.6 6072.4 6087.1 5789.9 5790.8 5809.8 5814.9 5833.6 5766.7 5818.3 5821.3 5825.3 5833.6 5701.6 5775.5 5814.8 5868.3 5888.6 5938.3 5948.3 5972.9 5984.5 6014.9 5698.7 5821.7 5870.4 5880.5 5891.5 17:04:34 INFO - PROCESS | 4394 | 17:04:34 INFO - PROCESS | 4394 | [#1] ext.html Cycles:180 Average:61424.01 Median:38689.61 stddev:139411.96 (360.3%) stddev-sans-first:139728.00 17:04:34 INFO - PROCESS | 4394 | Values: 495.9 547.6 550.8 556.3 565.7 37720.6 38327.2 38342.0 38423.0 38504.4 42774.1 43296.8 43359.3 43453.6 43643.8 8685.8 8951.1 8972.9 9015.0 9016.2 8809.1 8926.0 8952.3 9178.3 9300.2 9171.9 9275.3 9275.4 9280.9 9282.4 9164.8 9228.8 9237.9 9242.1 9247.8 8989.4 9131.8 9163.9 9167.4 9176.6 42875.4 43369.6 43376.3 43447.6 43479.0 3412.1 3432.1 3494.5 3516.8 3741.9 30058.2 31108.5 31520.2 31562.8 31761.8 3302.0 3436.0 3451.6 3506.9 3524.7 311586.0 314718.0 317669.0 320161.0 320170.0 49118.8 50030.0 68546.0 69047.0 69339.0 44193.8 44249.6 44269.1 44456.0 44518.8 17983.6 18342.7 18372.0 18394.1 18443.5 14507.2 14618.6 14636.5 14641.9 14644.0 15707.8 15722.5 15771.4 15795.3 15847.2 5900.6 6019.6 6032.7 6073.4 6113.6 1067.1 1069.8 1081.0 1099.4 1128.2 29858.3 29894.7 30363.4 30715.4 30951.7 1114.6 1129.8 1198.9 1222.2 1223.7 15446.8 15535.8 15694.8 15766.5 15922.2 340138.0 833665.0 849166.0 849545.0 857678.0 61846.7 62163.0 62425.0 62528.0 62832.7 1454.2 1462.2 1492.0 1497.7 1536.5 31351.7 31808.0 32293.7 32357.5 32732.5 50703.0 50900.5 51327.2 51516.5 51677.5 312402.0 318399.0 318761.0 319237.0 320941.0 35093.3 35199.1 35251.3 35445.8 35580.0 47564.8 47639.0 47865.0 47897.8 47951.3 38999.0 39052.4 39156.0 39992.8 40035.2 38874.8 39521.0 40237.8 40585.4 41144.6 39042.6 39682.6 40375.6 40391.0 40413.8 35098.0 35399.6 35678.8 35697.7 36172.8 26350.3 27371.3 27525.4 27540.6 27750.2 17:04:34 INFO - PROCESS | 4394 | 17:04:34 INFO - PROCESS | 4394 | [#2] jquery.html Cycles:180 Average:26184.90 Median:2472.96 stddev:72597.16 (2935.6%) stddev-sans-first:72774.93 17:04:34 INFO - PROCESS | 4394 | Values: 370.3 372.3 373.0 380.4 383.5 18353.6 18414.4 19390.9 19569.2 19588.2 18702.3 19076.9 19121.2 19196.1 19263.8 5545.9 5835.7 5842.6 5842.8 5843.2 5581.2 5732.4 5778.1 5826.7 5828.9 5715.5 5716.9 5721.7 5729.0 5744.7 5474.5 5668.7 5682.1 5689.3 5701.6 5103.0 5119.3 5119.8 5128.0 5128.1 21462.0 21780.2 22193.8 22527.5 22563.1 2424.2 2521.7 2573.6 2893.1 3183.4 13573.9 13937.1 14386.1 14423.4 14601.9 1943.2 1990.4 1991.2 2021.2 2065.1 64541.0 64583.4 65591.3 66968.3 67367.3 9782.0 9800.5 10148.1 10566.0 10868.2 14717.0 14835.8 14835.9 14841.3 14861.9 8373.5 8511.3 8609.2 8692.7 8707.4 8697.0 8818.4 8825.9 8889.2 8909.8 6107.9 6114.2 6182.4 6191.2 6280.4 1785.7 1796.5 1813.1 1824.1 1828.9 1022.3 1047.3 1123.9 1150.9 1176.3 17510.5 17649.1 17897.1 17980.8 18406.3 998.9 999.5 1024.7 1034.0 1062.3 9261.3 10893.1 10937.5 10953.4 10967.9 431979.0 432357.0 447183.0 449716.0 457535.0 69600.7 70256.3 70317.0 72416.0 73438.0 1080.9 1081.9 1091.9 1095.9 1110.9 16291.2 16393.8 16527.8 16610.3 16682.2 33340.2 33724.7 34137.3 34764.7 35143.9 45470.0 45954.8 46120.5 46422.1 46459.8 8529.1 8549.5 8575.4 8719.0 8846.4 11882.3 12755.1 12794.1 12907.0 13126.6 10366.2 10375.3 10416.8 10630.3 11133.6 10258.8 10373.8 10465.0 10521.4 11549.0 11694.9 12128.3 12277.0 12435.9 12438.8 8325.7 8411.9 8476.0 8540.1 8645.9 11682.1 12236.9 12256.0 12263.4 12316.1 17:04:34 INFO - PROCESS | 4394 | 17:04:34 INFO - PROCESS | 4394 | [#3] mootools.html Cycles:180 Average:5912.32 Median:2935.65 stddev:3160.36 (107.7%) stddev-sans-first:3152.14 17:04:34 INFO - PROCESS | 4394 | Values: 1540.0 1585.2 1815.7 1890.8 1950.5 7494.3 8004.5 8157.9 8267.4 8270.1 8277.3 8308.4 8344.1 8426.2 8445.5 2425.5 2458.5 2470.8 2471.4 2472.7 2212.5 2244.2 2248.8 2248.8 2251.9 2373.9 2379.9 2411.5 2437.3 2451.6 2388.9 2405.0 2407.7 2411.2 2420.0 2370.3 2375.2 2398.0 2408.7 2409.9 8490.5 8527.4 8548.7 8570.5 8576.0 5130.5 5268.5 5271.4 5273.3 5274.6 3150.3 3173.0 3206.6 3250.7 3286.2 948.2 969.9 982.1 994.1 1019.2 12094.9 12098.9 12123.6 12126.2 12139.4 4541.8 4543.5 4613.0 4638.3 4679.9 10218.4 10253.0 10282.5 10285.2 10328.3 5272.9 5281.1 5340.2 5354.3 5361.5 4660.5 4790.7 4835.4 4836.6 4839.4 3638.1 3716.2 3739.7 3739.9 3790.3 1099.9 1117.9 1118.9 1127.4 1128.7 1434.6 1448.5 1453.4 1463.4 1473.4 8067.3 8129.6 8141.5 8156.5 8188.9 527.3 527.4 530.0 531.1 538.4 6006.5 6037.3 6038.2 6105.4 6152.1 10249.6 10662.8 10691.9 10700.5 10827.9 9552.0 10380.1 10467.8 10493.3 10598.8 7773.9 7865.7 7872.9 7890.0 7909.0 7639.1 7661.5 7703.4 7773.1 7805.3 8698.6 9004.4 9011.3 9059.0 9092.3 8997.9 9083.9 9109.8 9231.8 9251.1 7002.7 7759.3 8004.7 8169.2 8325.9 8111.5 8135.1 8141.6 8168.8 8178.2 7141.1 7167.8 7195.9 7220.8 7479.0 7198.7 7216.4 7277.8 7294.1 7327.0 7308.7 7327.0 7358.4 7369.5 7381.3 6955.7 6963.2 7013.6 7035.0 7048.8 7085.9 7189.5 7213.6 7217.0 7223.9 17:04:34 INFO - PROCESS | 4394 | 17:04:34 INFO - PROCESS | 4394 | [#4] prototype.html Cycles:180 Average:5662.66 Median:6476.79 stddev:1735.39 (26.8%) stddev-sans-first:1693.74 17:04:34 INFO - PROCESS | 4394 | Values: 344.9 348.2 348.7 349.1 353.5 6328.8 6386.0 6393.5 6424.7 6438.6 6297.2 6323.5 6326.3 6331.8 6345.0 4713.3 4828.1 4843.0 4852.2 4886.0 4819.2 4821.2 4822.7 4844.2 4856.1 4773.5 4776.6 4784.8 4786.2 4789.8 4789.6 4790.3 4791.3 4797.5 4806.4 4171.2 4175.5 4175.7 4176.2 4178.3 5919.1 6052.5 6094.7 6106.8 6115.7 5606.8 5626.0 5627.7 5639.6 5644.2 6652.3 6668.6 6679.5 6715.4 6725.6 4652.5 4654.2 4659.6 4662.6 4672.2 6892.1 6918.3 6925.5 6939.8 6943.7 4521.4 4589.1 4653.4 4661.6 4665.2 4668.6 4691.3 4696.5 4718.0 4726.4 5406.2 5458.3 5461.9 5463.8 5473.1 6659.7 6672.3 6675.9 6676.5 6684.2 1690.8 1699.6 1699.7 1700.8 1701.0 1081.2 1103.2 1106.5 1106.8 1138.9 6493.5 6540.5 6541.9 6567.9 6568.5 6961.9 6965.9 7003.7 7010.1 7036.6 6460.0 6536.7 6618.0 6620.6 6639.4 3812.8 3852.9 3853.5 3853.9 3860.5 7297.2 7323.9 7347.4 7350.9 7380.6 7230.8 7235.7 7243.8 7248.3 7283.7 7161.0 7348.0 7389.8 7391.0 7394.0 7024.5 7038.4 7047.9 7099.9 7105.5 6945.4 6961.2 6967.6 6974.5 6982.4 7303.6 7328.8 7338.2 7347.7 7383.8 4798.7 4940.7 4947.3 4984.8 4988.2 6998.8 7018.6 7031.0 7033.3 7037.6 6761.3 6765.0 6811.4 6817.2 6826.0 6768.5 6783.6 6792.5 6797.9 6811.4 6559.1 6680.4 6748.8 6752.2 6755.6 6888.3 6916.6 6920.5 6925.4 6935.8 6715.5 6760.0 6760.3 6764.8 6771.5 17:04:34 INFO - PROCESS | 4394 | 17:04:34 INFO - PROCESS | 4394 | [#5] yui.html Cycles:180 Average:14080.65 Median:24678.54 stddev:15964.29 (64.7%) stddev-sans-first:15977.65 17:04:34 INFO - PROCESS | 4394 | Values: 743.2 758.9 768.2 771.4 797.8 14524.8 14744.3 14748.7 14751.3 14836.9 14075.9 14079.9 14116.4 14149.3 14198.6 922.5 953.5 953.7 954.2 954.4 755.7 926.1 958.0 958.8 960.9 973.9 979.9 981.7 985.4 985.4 968.1 974.2 976.7 980.4 983.6 720.3 723.1 724.5 724.6 725.3 14739.7 14762.5 14864.8 14896.8 14953.9 12598.9 12873.9 13088.7 13182.3 13230.5 11161.3 11448.7 11576.4 11634.6 11640.7 3814.8 3829.1 3854.5 3859.0 3874.3 52395.2 52707.2 53325.7 53837.0 53871.9 10438.0 10444.1 10532.5 10567.4 10601.1 19769.9 19771.0 19826.8 19838.0 19894.5 7746.8 7890.1 7898.1 8094.5 8388.9 4485.8 4560.7 4569.4 4573.2 4593.0 3351.6 3371.2 3372.4 3372.7 3376.2 581.9 597.3 604.6 606.8 614.3 597.9 651.1 691.0 699.9 723.2 8386.9 8764.9 8806.6 8865.8 8974.9 525.6 622.3 642.3 664.3 672.5 3964.5 4067.5 4094.8 4125.9 4250.2 55474.0 57218.0 57314.7 57467.4 57535.7 49864.3 50020.7 50108.2 50115.5 51128.5 43913.0 44840.6 44871.3 45388.5 46128.3 8172.7 8223.3 8279.0 8526.2 8577.2 35013.0 35369.6 36561.6 36565.5 37094.8 40206.6 40271.0 42089.6 43190.4 43385.0 10487.5 10511.1 10561.0 10601.4 10744.6 11532.8 11586.2 11613.5 11675.1 12323.2 11509.4 11748.4 11780.9 11943.6 12094.5 11539.9 11540.1 11727.9 11753.6 12081.9 10631.5 11016.0 11035.1 11888.1 11902.6 9442.2 9565.3 9871.3 9996.7 10030.4 9475.1 9600.8 9617.9 10085.3 10170.5 17:04:34 INFO - PROCESS | 4394 | -------- Summary: end -------- 17:04:34 INFO - PROCESS | 4394 | 17:04:35 INFO - TEST-INFO | 4394: exit 0 17:04:35 INFO - TEST-OK | dromaeo_css | took 1109559ms 17:04:35 INFO - TEST-START | kraken 17:04:35 INFO - operating with platform_type : linux_ 17:04:35 INFO - Initialising browser for kraken test... 17:04:35 INFO - TEST-INFO | started process 4633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_VG9Pk/profile http://localhost:48795/getInfo.html) 17:04:39 INFO - PROCESS | 4633 | 17:04:39 INFO - PROCESS | 4633 | (process:4714): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:04:40 INFO - PROCESS | 4633 | __metrics Screen width/height:1600/1200 17:04:40 INFO - PROCESS | 4633 | colorDepth:24 17:04:40 INFO - PROCESS | 4633 | Browser inner width/height: 1024/697 17:04:40 INFO - PROCESS | 4633 | __metrics 17:04:40 ERROR - PROCESS | 4633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 17:04:41 INFO - TEST-INFO | 4633: exit 0 17:04:41 INFO - Browser initialized. 17:04:41 INFO - Running cycle 1/1 for kraken test... 17:04:41 INFO - TEST-INFO | started process 4764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_VG9Pk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:04:43 INFO - PROCESS | 4764 | 17:04:43 INFO - PROCESS | 4764 | (process:4834): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:04:53 INFO - PROCESS | 4764 | RSS: Main: 149762048 17:04:53 INFO - PROCESS | 4764 | 17:04:56 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48795/tests/kraken/driver.html?testName=audio-beat-detection) 17:04:56 INFO - PROCESS | 4764 | RSS: Main: 153845760 17:04:56 INFO - PROCESS | 4764 | 17:04:59 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48795/tests/kraken/driver.html?testName=audio-dft) 17:04:59 INFO - PROCESS | 4764 | RSS: Main: 154365952 17:04:59 INFO - PROCESS | 4764 | 17:05:02 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48795/tests/kraken/driver.html?testName=audio-fft) 17:05:03 INFO - PROCESS | 4764 | RSS: Main: 154615808 17:05:03 INFO - PROCESS | 4764 | 17:05:05 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48795/tests/kraken/driver.html?testName=audio-oscillator) 17:05:06 INFO - PROCESS | 4764 | RSS: Main: 154923008 17:05:06 INFO - PROCESS | 4764 | 17:05:08 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48795/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:05:08 INFO - PROCESS | 4764 | RSS: Main: 154648576 17:05:08 INFO - PROCESS | 4764 | 17:05:11 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48795/tests/kraken/driver.html?testName=imaging-darkroom) 17:05:12 INFO - PROCESS | 4764 | RSS: Main: 154812416 17:05:12 INFO - PROCESS | 4764 | 17:05:15 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48795/tests/kraken/driver.html?testName=imaging-desaturate) 17:05:16 INFO - PROCESS | 4764 | RSS: Main: 154853376 17:05:16 INFO - PROCESS | 4764 | 17:05:19 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48795/tests/kraken/driver.html?testName=json-parse-financial) 17:05:19 INFO - PROCESS | 4764 | RSS: Main: 154923008 17:05:19 INFO - PROCESS | 4764 | 17:05:21 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48795/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:05:22 INFO - PROCESS | 4764 | RSS: Main: 154820608 17:05:22 INFO - PROCESS | 4764 | 17:05:23 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48795/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:05:24 INFO - PROCESS | 4764 | RSS: Main: 155021312 17:05:24 INFO - PROCESS | 4764 | 17:05:26 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48795/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:05:27 INFO - PROCESS | 4764 | RSS: Main: 155463680 17:05:27 INFO - PROCESS | 4764 | 17:05:29 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:05:30 INFO - PROCESS | 4764 | RSS: Main: 155406336 17:05:30 INFO - PROCESS | 4764 | 17:05:32 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:05:33 INFO - PROCESS | 4764 | RSS: Main: 155574272 17:05:33 INFO - PROCESS | 4764 | 17:05:34 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48795/tests/kraken/driver.html?testName=ai-astar) 17:05:35 INFO - PROCESS | 4764 | RSS: Main: 157151232 17:05:35 INFO - PROCESS | 4764 | 17:05:35 INFO - PROCESS | 4764 | __start_tp_report 17:05:35 INFO - PROCESS | 4764 | _x_x_mozilla_page_load 17:05:35 INFO - PROCESS | 4764 | _x_x_mozilla_page_load_details 17:05:35 INFO - PROCESS | 4764 | |i|pagename|runs| 17:05:35 INFO - PROCESS | 4764 | |0;ai-astar;111;104;112;110;112;124;110;111;111;112 17:05:35 INFO - PROCESS | 4764 | |1;audio-beat-detection;163;133;154;168;130;152;169;130;172;128 17:05:35 INFO - PROCESS | 4764 | |2;audio-dft;166;165;163;164;164;162;163;163;165;162 17:05:35 INFO - PROCESS | 4764 | |3;audio-fft;75;77;76;158;73;76;72;75;167;78 17:05:35 INFO - PROCESS | 4764 | |4;audio-oscillator;93;92;137;93;93;94;145;93;93;148 17:05:35 INFO - PROCESS | 4764 | |5;imaging-gaussian-blur;117;118;117;117;118;117;118;117;116;118 17:05:35 INFO - PROCESS | 4764 | |6;imaging-darkroom;146;148;147;147;146;147;146;146;147;147 17:05:35 INFO - PROCESS | 4764 | |7;imaging-desaturate;96;96;97;96;97;96;96;97;96;96 17:05:35 INFO - PROCESS | 4764 | |8;json-parse-financial;55;55;55;56;55;63;55;57;66;55 17:05:35 INFO - PROCESS | 4764 | |9;json-stringify-tinderbox;66;66;66;67;66;66;67;66;66;67 17:05:35 INFO - PROCESS | 4764 | |10;stanford-crypto-aes;79;77;80;80;81;81;80;78;79;79 17:05:35 INFO - PROCESS | 4764 | |11;stanford-crypto-ccm;118;119;118;115;117;124;126;115;136;118 17:05:35 INFO - PROCESS | 4764 | |12;stanford-crypto-pbkdf2;136;153;145;149;147;135;147;145;150;135 17:05:35 INFO - PROCESS | 4764 | |13;stanford-crypto-sha256-iterative;66;70;68;69;70;69;70;68;71;66 17:05:35 INFO - PROCESS | 4764 | __end_tp_report 17:05:35 INFO - PROCESS | 4764 | __start_cc_report 17:05:35 INFO - PROCESS | 4764 | _x_x_mozilla_cycle_collect,824 17:05:35 INFO - PROCESS | 4764 | __end_cc_report 17:05:35 INFO - PROCESS | 4764 | __startTimestamp1464912335118__endTimestamp 17:05:35 INFO - PROCESS | 4764 | 17:05:35 INFO - PROCESS | 4764 | ------- Summary: start ------- 17:05:35 INFO - PROCESS | 4764 | Number of tests: 14 17:05:35 INFO - PROCESS | 4764 | 17:05:35 INFO - PROCESS | 4764 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.50 stddev:4.92 (4.4%) stddev-sans-first:5.21 17:05:35 INFO - PROCESS | 4764 | Values: 111.0 104.0 112.0 110.0 112.0 124.0 110.0 111.0 111.0 112.0 17:05:35 INFO - PROCESS | 4764 | 17:05:35 INFO - PROCESS | 4764 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:158.50 stddev:18.05 (11.4%) stddev-sans-first:18.51 17:05:35 INFO - PROCESS | 4764 | Values: 163.0 133.0 154.0 168.0 130.0 152.0 169.0 130.0 172.0 128.0 17:05:35 INFO - PROCESS | 4764 | 17:05:35 INFO - PROCESS | 4764 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:1.34 (0.8%) stddev-sans-first:1.13 17:05:35 INFO - PROCESS | 4764 | Values: 166.0 165.0 163.0 164.0 164.0 162.0 163.0 163.0 165.0 162.0 17:05:35 INFO - PROCESS | 4764 | 17:05:35 INFO - PROCESS | 4764 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.50 stddev:36.89 (48.9%) stddev-sans-first:38.57 17:05:35 INFO - PROCESS | 4764 | Values: 75.0 77.0 76.0 158.0 73.0 76.0 72.0 75.0 167.0 78.0 17:05:35 INFO - PROCESS | 4764 | 17:05:35 INFO - PROCESS | 4764 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:93.00 stddev:24.47 (26.3%) stddev-sans-first:25.33 17:05:35 INFO - PROCESS | 4764 | Values: 93.0 92.0 137.0 93.0 93.0 94.0 145.0 93.0 93.0 148.0 17:05:35 INFO - PROCESS | 4764 | 17:05:35 INFO - PROCESS | 4764 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 17:05:35 INFO - PROCESS | 4764 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 116.0 118.0 17:05:35 INFO - PROCESS | 4764 | 17:05:35 INFO - PROCESS | 4764 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 17:05:35 INFO - PROCESS | 4764 | Values: 146.0 148.0 147.0 147.0 146.0 147.0 146.0 146.0 147.0 147.0 17:05:35 INFO - PROCESS | 4764 | 17:05:35 INFO - PROCESS | 4764 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:05:35 INFO - PROCESS | 4764 | Values: 96.0 96.0 97.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 17:05:35 INFO - PROCESS | 4764 | 17:05:35 INFO - PROCESS | 4764 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:55.50 stddev:3.97 (7.1%) stddev-sans-first:4.13 17:05:35 INFO - PROCESS | 4764 | Values: 55.0 55.0 55.0 56.0 55.0 63.0 55.0 57.0 66.0 55.0 17:05:35 INFO - PROCESS | 4764 | 17:05:35 INFO - PROCESS | 4764 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 17:05:35 INFO - PROCESS | 4764 | Values: 66.0 66.0 66.0 67.0 66.0 66.0 67.0 66.0 66.0 67.0 17:05:35 INFO - PROCESS | 4764 | 17:05:35 INFO - PROCESS | 4764 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:80.00 stddev:1.26 (1.6%) stddev-sans-first:1.33 17:05:35 INFO - PROCESS | 4764 | Values: 79.0 77.0 80.0 80.0 81.0 81.0 80.0 78.0 79.0 79.0 17:05:35 INFO - PROCESS | 4764 | 17:05:35 INFO - PROCESS | 4764 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:118.50 stddev:6.47 (5.5%) stddev-sans-first:6.79 17:05:35 INFO - PROCESS | 4764 | Values: 118.0 119.0 118.0 115.0 117.0 124.0 126.0 115.0 136.0 118.0 17:05:35 INFO - PROCESS | 4764 | 17:05:35 INFO - PROCESS | 4764 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.20 Median:147.00 stddev:6.56 (4.5%) stddev-sans-first:6.25 17:05:35 INFO - PROCESS | 4764 | Values: 136.0 153.0 145.0 149.0 147.0 135.0 147.0 145.0 150.0 135.0 17:05:35 INFO - PROCESS | 4764 | 17:05:35 INFO - PROCESS | 4764 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.50 stddev:1.70 (2.5%) stddev-sans-first:1.50 17:05:35 INFO - PROCESS | 4764 | Values: 66.0 70.0 68.0 69.0 70.0 69.0 70.0 68.0 71.0 66.0 17:05:35 INFO - PROCESS | 4764 | -------- Summary: end -------- 17:05:35 INFO - PROCESS | 4764 | 17:05:35 INFO - TEST-INFO | 4764: exit 0 17:05:36 INFO - TEST-OK | kraken | took 60430ms 17:05:36 INFO - SUITE-END | took 1169s 17:05:36 INFO - Completed test suite (00:19:30) 17:05:36 INFO - javascript benchmark 17:05:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3335.7831740936836, 3415.5218269442285, 3416.4533674612035, 3447.6897079262862, 3465.116395319195, 5507.256520369749, 5553.888922221553, 5556.749946252418, 5558.666480011202, 5629.437056294369, 5608.270924779783, 5612.017896868052, 5634.577406694504, 5636.605437619368, 5637.774489020445, 5086.898262034757, 5173.094708426029, 5178.0679477694, 5212.374515058198, 5235.293235413209, 4994.97502512487, 5117.181250999841, 5210.661307015051, 5212.6611770235, 5252.107141785887, 5144.768485418165, 5151.098557752397, 5187.092258854705, 5206.062908676437, 5257.263983042377, 5138.126518491866, 5149.742512874342, 5162.199859021857, 5164.535191832753, 5191.532762051395, 4962.851114466572, 4973.403191617029, 5100.591952643779, 5123.590112790967, 5141.203113517411, 5427.158790387496, 5440.972795136038, 5481.12302031677, 5487.396386397493, 5505.229267902497, 6020.5785595008365, 6035.245594300713, 6080.787172448987, 6085.208922840003, 6085.878282434326, 5896.056630939072, 5978.372270911535, 6033.0, 6056.152138700585, 6080.878382432371, 5664.631798933056, 5682.573806964453, 5684.7157642118145, 5686.402927692574, 5690.601657883991, 6053.697315134225, 6175.783847565313, 6185.907211391833, 6190.133381326618, 6191.380861913773, 5907.409259074058, 5967.492763115097, 5983.431574000463, 5984.730687119003, 6002.0996850472775, 6079.756809727562, 6089.695515224221, 6090.908636370458, 6092.329843717188, 6117.143599896018, 5785.450382213683, 5964.642121472725, 6010.3689112643415, 6018.518518518508, 6035.637861728311, 5930.644161350333, 5961.0, 5978.850528736816, 5995.370486098984, 6017.308009578955, 4518.932216016762, 4530.954690453119, 4535.047639995571, 4552.408186935677, 4559.908801824011, 3998.5801490843623, 4030.8186131624147, 4093.570175131628, 4114.814833332507, 4166.208420400114, 5546.611737178439, 5684.971575142098, 5708.71456427177, 5742.511886489611, 5811.895739809423, 6035.336113027563, 6039.516838652898, 6107.755689772448, 6111.694415279218, 6115.388461153938, 5527.0, 5709.229254050733, 5771.538276937835, 5776.624519406225, 5776.884462310731, 5084.491550844886, 5101.566366858784, 5110.3356563646485, 5148.9742551287, 5150.330457040635, 6079.574429789872, 6194.473469755121, 6198.690065496708, 6199.56603037783, 6204.658743769046, 5781.797637082682, 5997.820065398045, 6000.909986350295, 6003.069524223665, 6068.029115341524, 6265.96867015662, 6313.179286692701, 6337.556371053982, 6342.048692695948, 6342.270638876588, 5985.820425387245, 6040.909386359121, 6056.545759068175, 6058.787942421994, 6062.514998799998, 5858.414158584107, 5955.076963070731, 6019.608725432833, 6072.392760724069, 6087.117367981707, 5789.884202316014, 5790.768369265183, 5809.82570522885, 5814.94185058144, 5833.620814647034, 5766.740496677576, 5818.272715910512, 5821.27234095738, 5825.271841019872, 5833.620814647034, 5701.600887937804, 5775.48020678141, 5814.76740930358, 5868.295804503487, 5888.646681199141, 5938.257717785277, 5948.256467941507, 5972.940270597239, 5984.521238301013, 6014.9097763534455, 5698.686572238566, 5821.7089145543405, 5870.383609721089, 5880.529557635465, 5891.528677705859], "unit": "score", "name": "dojo.html", "value": 5556.375967204977}, {"lowerIsBetter": false, "replicates": [495.87107352088447, 547.6166683321675, 550.8402563256656, 556.3018411893073, 565.7312776431196, 37720.622793772054, 38327.233455330876, 38342.04144896383, 38423.039424014416, 38504.422433663516, 42774.14451710964, 43296.783516082454, 43359.34960975588, 43453.565464345425, 43643.78178109113, 8685.782855428633, 8951.104889511029, 8972.910270897306, 9014.954925225366, 9016.233620142295, 8809.119088091204, 8925.95537022314, 8952.283817294634, 9178.265738740918, 9300.20948219402, 9171.908280917172, 9275.257979361635, 9275.39709918853, 9280.907190928072, 9282.396644218104, 9164.816703665923, 9228.815423691522, 9237.907620923772, 9242.12199841014, 9247.768805779842, 8989.415687980325, 9131.77170570741, 9163.908360916439, 9167.358284920057, 9176.632934682604, 42875.35686964667, 43369.56630433687, 43376.3493547597, 43447.56552434467, 43479.0, 3412.146963259185, 3432.1076520104702, 3494.5457090578316, 3516.753827232095, 3741.906452338686, 30058.24854378636, 31108.533371999438, 31520.211994700087, 31562.842185788923, 31761.841190793897, 3301.950470742941, 3436.037909385376, 3451.5858097028517, 3506.9298614027575, 3524.665156810099, 311586.0, 314718.0, 317669.0, 320161.0, 320170.0, 49118.75440622774, 50030.0, 68546.0, 69047.0, 69339.0, 44193.77903110464, 44249.55750442519, 44269.11461770811, 44456.0, 44518.777406112764, 17983.550411239823, 18342.724859127124, 18372.0, 18394.080295985146, 18443.538911527317, 14507.202103884387, 14618.634534136732, 14636.487722929647, 14641.92679036598, 14644.0, 15707.764383534257, 15722.528324150293, 15771.447999320199, 15795.289211985488, 15847.207639617973, 5900.616459930091, 6019.60872543292, 6032.698365081728, 6073.362296958844, 6113.602615829956, 1067.114295135036, 1069.8288273876142, 1080.989190108089, 1099.4008265495324, 1128.1989787251143, 29858.253543661584, 29894.701052989625, 30363.392732145232, 30715.38569228603, 30951.69048309533, 1114.5876025870318, 1129.7627498225465, 1198.9160758746978, 1222.2255480060214, 1223.687959570304, 15446.768298475532, 15535.766963495556, 15694.76457853133, 15766.527004189893, 15922.203889805694, 340138.0, 833665.0, 849166.0, 849545.0, 857678.0, 61846.69076654678, 62163.0, 62425.0, 62528.0, 62832.68583657053, 1454.1638557829501, 1462.159258426409, 1491.9850801491846, 1497.7154340675236, 1536.4622382166376, 31351.686483134876, 31808.0, 32293.677063230007, 32357.51463727999, 32732.50901236531, 50703.0, 50900.490995089574, 51327.230091547906, 51516.48483515117, 51677.48322516727, 312402.0, 318399.0, 318761.0, 319237.0, 320941.0, 35093.29813403769, 35199.12002199965, 35251.294974100885, 35445.82277088598, 35580.0, 47564.762176190285, 47639.0, 47865.0, 47897.76051119722, 47951.28073078977, 38999.0, 39052.41421378625, 39156.0, 39992.80003599964, 40035.1992960145, 38874.80562597282, 39521.0, 40237.798811005756, 40585.404574094304, 41144.588554114074, 39042.609573903894, 39682.603173969044, 40375.59624403718, 40391.0, 40413.79793101016, 35098.0, 35399.64600354066, 35678.821605892845, 35697.72003794135, 36172.81913590415, 26350.341241469116, 27371.31571710723, 27525.44949101047, 27540.58689119705, 27750.167494975183], "unit": "score", "name": "ext.html", "value": 19785.973472090558}, {"lowerIsBetter": false, "replicates": [370.34818719054454, 372.25920418367457, 372.96083911189334, 380.40656575741843, 383.45932235547883, 18353.632927341445, 18414.447566573006, 19390.903045484753, 19569.217231310766, 19588.216471341166, 18702.251909923587, 19076.90461547694, 19121.23515059396, 19196.136173872175, 19263.807361926378, 5545.890821835639, 5835.708214589275, 5842.620229685057, 5842.766289348442, 5843.18195452637, 5581.190727344532, 5732.369439361667, 5778.104393818965, 5826.708664566776, 5828.883422331551, 5715.514181294574, 5716.857078573048, 5721.713914304289, 5729.026065568843, 5744.712764361786, 5474.452554744534, 5668.716564171796, 5682.147677848315, 5689.345725241609, 5701.57238207134, 5102.974485127587, 5119.257707632372, 5119.795208191668, 5128.025675121715, 5128.1282182029145, 21462.034208460656, 21780.237691680715, 22193.77806221933, 22527.549449010927, 22563.097476100935, 2424.175780234729, 2521.735217802123, 2573.6010918307693, 2893.14652177606, 3183.442897492953, 13573.932130339284, 13937.09408888419, 14386.136831790127, 14423.423063077464, 14601.853981460155, 1943.2227109156308, 1990.4028791362678, 1991.2134706790882, 2021.191523390641, 2065.10168076887, 64541.0, 64583.3541664582, 65591.344086559, 66968.33031669719, 67367.32632673708, 9781.951090244645, 9800.460974646463, 10148.137408320228, 10566.0, 10868.239223254455, 14717.043392179474, 14835.777463338058, 14835.851641483447, 14841.332140053724, 14861.851381486047, 8373.539455329894, 8511.319094472427, 8609.182127697859, 8692.695755648521, 8707.390482666153, 8696.95651521751, 8818.426802257833, 8825.91174088251, 8889.244414224733, 8909.821803564022, 6107.938920610826, 6114.174586430775, 6182.381761823782, 6191.19514463126, 6280.403361680633, 1785.7321401789575, 1796.5059608607476, 1813.1206364913007, 1824.087956021989, 1828.8994105324068, 1022.3150489172273, 1047.3297089862494, 1123.9269447486051, 1150.8676502202186, 1176.335370515656, 17510.474685759447, 17649.117544123, 17897.105144742713, 17980.820191798175, 18406.26374945014, 998.9450580218013, 999.5252255178732, 1024.6874703215442, 1033.9896601033893, 1062.2564205056492, 9261.259099272042, 10893.074088702391, 10937.507812148473, 10953.397563133945, 10967.890321096687, 431979.0, 432357.0, 447183.0, 449716.0, 457535.0, 69600.65199674071, 70256.29743702599, 70317.0, 72416.0, 73438.0, 1080.897314755097, 1081.9188560857967, 1091.879893211746, 1095.895889890459, 1110.9277896936674, 16291.185440727679, 16393.83606163923, 16527.83472165263, 16610.335586576402, 16682.16589170561, 33340.166495837795, 33724.662753372155, 34137.31725365528, 34764.65235347614, 35143.94568162959, 45470.0, 45954.770226149994, 46120.53879461296, 46422.071558567965, 46459.767701161276, 8529.104444033288, 8549.487030778173, 8575.3997220194, 8718.956405217934, 8846.424982376126, 11882.346470943836, 12755.107142499935, 12794.14484899703, 12906.967442604382, 13126.60620181396, 10366.170706343626, 10375.273730839072, 10416.791664166825, 10630.30902991303, 11133.610323638633, 10258.794824103625, 10373.792524149625, 10465.0, 10521.421321827373, 11549.0, 11694.941525292319, 12128.272303661808, 12277.0, 12435.875641243834, 12438.751224975631, 8325.708600198965, 8411.915880841114, 8476.0, 8540.14598540141, 8645.91354086451, 11682.123840712151, 12236.938815305866, 12256.0, 12263.448144833683, 12316.13787034899], "unit": "score", "name": "jquery.html", "value": 9092.572172418424}, {"lowerIsBetter": false, "replicates": [1540.0451719933642, 1585.151943710115, 1815.718563622639, 1890.7636545431822, 1950.5318723506355, 7494.325510704036, 8004.4797088189225, 8157.877631835512, 8267.379946504014, 8270.131636178205, 8277.296429803459, 8308.418410711252, 8344.08215096339, 8426.199511046456, 8445.49327040378, 2425.539147561962, 2458.4714286428416, 2470.8270421070533, 2471.369800700828, 2472.7032756069298, 2212.5353675728115, 2244.2257421189665, 2248.820094392453, 2248.8425810193294, 2251.8761468119246, 2373.9406514837096, 2379.9048038078454, 2411.4815314707334, 2437.3297343230574, 2451.6322551617222, 2388.940276493084, 2405.025964484387, 2407.735149133594, 2411.1801987324307, 2419.9637005444756, 2370.3007612754277, 2375.239923224569, 2398.0, 2408.710954685449, 2409.8795060246916, 8490.53302068386, 8527.360447966428, 8548.658053677846, 8570.528620925847, 8576.0, 5130.53825155734, 5268.473152684739, 5271.446498117681, 5273.31446911899, 5274.604404669665, 3150.3384289299274, 3173.0480855743185, 3206.64726880043, 3250.6586808385014, 3286.194882253863, 948.184561277301, 969.8933117357085, 982.0670363155032, 994.1152374386802, 1019.1642852860657, 12094.939525302405, 12098.87901120995, 12123.575674851338, 12126.211796233216, 12139.393030348447, 4541.84103556374, 4543.454785425704, 4612.953870461252, 4638.257878739386, 4679.883002924954, 10218.437985910698, 10253.025962533547, 10282.537285822156, 10285.228607854291, 10328.328658637165, 5272.92090618641, 5281.0758117329315, 5340.172273297645, 5354.303940487712, 5361.51746342831, 4660.510646382081, 4790.664653474293, 4835.395575553056, 4836.564709176191, 4839.395075615548, 3638.1086633774366, 3716.21959388526, 3739.7382183247455, 3739.9252014959548, 3790.29879472293, 1099.8845121262311, 1117.921745477825, 1118.888111188891, 1127.3517727306833, 1128.6726849213635, 1434.619825746178, 1448.5147475595793, 1453.382312517176, 1463.370750577262, 1473.4474572035488, 8067.273945344947, 8129.593520323961, 8141.470804397695, 8156.510609363457, 8188.877166842502, 527.30659183174, 527.3724268120924, 530.0485628297216, 531.1183435497056, 538.4238864415038, 6006.489448396847, 6037.275526936795, 6038.18484504595, 6105.419985101408, 6152.077188421683, 10249.641262555775, 10662.840057399146, 10691.946540267249, 10700.501929729844, 10827.891721082846, 9552.0, 10380.117689996436, 10467.84298235527, 10493.26547141708, 10598.788024239626, 7773.883391749128, 7865.724699635485, 7872.881906771403, 7889.960550197212, 7909.0, 7639.121501027453, 7661.540307581563, 7703.383729301754, 7773.144954055162, 7805.258500442676, 8698.60856261457, 9004.41471304363, 9011.324150688855, 9058.954705226695, 9092.318076144447, 8997.865032024656, 9083.863742044006, 9109.77225569366, 9231.76920576991, 9251.121143491358, 7002.719891204295, 7759.3404560610725, 8004.679812807422, 8169.223923727236, 8325.916740832514, 8111.472754270953, 8135.064467586067, 8141.592920354077, 8168.754937351889, 8178.223068808454, 7141.071660684078, 7167.784966451015, 7195.928040719526, 7220.819479513054, 7479.027726395534, 7198.71205151788, 7216.3505284524645, 7277.781666550012, 7294.088238970129, 7326.96336518314, 7308.707651693872, 7326.974223608806, 7358.448116391185, 7369.520981136209, 7381.335679788845, 6955.721771129098, 6963.2340442552295, 7013.649317534205, 7034.964825175842, 7048.788536343918, 7085.893711594227, 7189.460790440633, 7213.639318034182, 7216.96391518039, 7223.891641625485], "unit": "score", "name": "mootools.html", "value": 4732.843071456525}, {"lowerIsBetter": false, "replicates": [344.94998225257336, 348.23214811340995, 348.6966339284822, 349.11673466130696, 353.4821486522246, 6328.778492752755, 6385.999999999988, 6393.52048596356, 6424.710888010033, 6438.551325951665, 6297.244330680313, 6323.5257355698395, 6326.272478664955, 6331.841703957403, 6345.016522439029, 4713.293006049103, 4828.082664293773, 4842.97578512107, 4852.223644216926, 4885.999999999991, 4819.180739274332, 4821.156297647915, 4822.686525375857, 4844.20070688336, 4856.1016212000895, 4773.498782627827, 4776.570108690217, 4784.808607655689, 4786.186348320776, 4789.760511974405, 4789.592884604813, 4790.305405716152, 4791.257355109963, 4797.496262892416, 4806.44725856524, 4171.165766846643, 4175.498940127204, 4175.665946724254, 4176.227397931362, 4178.289690752579, 5919.112133180014, 6052.54605904559, 6094.720108777162, 6106.816795496098, 6115.663638499881, 5606.831795046114, 5626.015447296707, 5627.7467513961565, 5639.633423827479, 5644.209810626516, 6652.268250492442, 6668.566543174727, 6679.532432729711, 6715.3620406061345, 6725.562838415536, 4652.488226295105, 4654.162250794856, 4659.580637742585, 4662.603678687316, 4672.229082201433, 6892.069570607954, 6918.308169183092, 6925.480588955848, 6939.791806245871, 6943.72225110995, 4521.3896124023495, 4589.059242855206, 4653.441587009581, 4661.627069834405, 4665.206914824488, 4668.5798278155125, 4691.319758634979, 4696.459907110726, 4718.0, 4726.432828060655, 5406.162044883049, 5458.344998600193, 5461.863453413696, 5463.808766693147, 5473.124300111963, 6659.733610655617, 6672.2994085621285, 6675.86648267032, 6676.53264271506, 6684.231313398924, 1690.797104347486, 1699.600593860442, 1699.7110491216522, 1700.8129105798353, 1701.0, 1081.1620993729923, 1103.227740581596, 1106.5463160104318, 1106.756513567014, 1138.925969811976, 6493.545451818327, 6540.542162048611, 6541.934580654132, 6567.868642627121, 6568.474522038226, 6961.895571566431, 6965.860682786316, 7003.719851205997, 7010.123734533184, 7036.577805331594, 6460.030995350641, 6536.673166341759, 6618.007298905202, 6620.602763834186, 6639.3692599203, 3812.8284227209842, 3852.8844134676006, 3853.5183102112237, 3853.8843834684444, 3860.4595356650093, 7297.197308296083, 7323.926760732431, 7347.448941329421, 7350.889736653954, 7380.5940673263485, 7230.783076507713, 7235.746748863765, 7243.782686519413, 7248.347648711641, 7283.672234749449, 7161.0, 7348.0, 7389.778306650809, 7390.96304518474, 7394.0, 7024.473164512579, 7038.40173585251, 7047.894281585678, 7099.893501597583, 7105.46708996817, 6945.374916257561, 6961.199462061725, 6967.616781076887, 6974.4769142315545, 6982.406495447944, 7303.634818259172, 7328.78013659591, 7338.192798792022, 7347.66935487915, 7383.778486645409, 4798.66409351356, 4940.654154209171, 4947.3073769671555, 4984.800607975641, 4988.2268248420105, 6998.790036298919, 7018.649067546704, 7031.0, 7033.331833475811, 7037.612931288828, 6761.256261811099, 6764.966175169093, 6811.352921472452, 6817.181938167451, 6826.0, 6768.4585233182215, 6783.59298442095, 6792.456603471809, 6797.864042719217, 6811.421029212573, 6559.0817285579105, 6680.432163266177, 6748.763793267212, 6752.223494298219, 6755.594664320157, 6888.276730943179, 6916.619585922621, 6920.508616898013, 6925.445964322943, 6935.791926242221, 6715.496337774589, 6760.01979712929, 6760.256371799196, 6764.763233287008, 6771.492138089565], "unit": "score", "name": "prototype.html", "value": 5092.742085463267}, {"lowerIsBetter": false, "replicates": [743.1936349061269, 758.9279018493248, 768.2356055724555, 771.4407054885208, 797.7566842113157, 14524.78212826807, 14744.33650485728, 14748.70502589949, 14751.336189871454, 14836.851631483682, 14075.859241407583, 14079.859201407982, 14116.43534258631, 14149.292535373215, 14198.645033874158, 922.483409290796, 953.5280036381967, 953.7186529973675, 954.1889394015067, 954.3558098283665, 755.7014979083286, 926.1248120526105, 958.0276019839868, 958.832204364237, 960.8654788329604, 973.8539219117118, 979.8677178580907, 981.7447463659429, 985.4136788610801, 985.4333758089092, 968.1480297338297, 974.1865542272211, 976.653288082731, 980.4460479828874, 983.5524836199547, 720.2761224968925, 723.0528008309132, 724.4711360706661, 724.6449239872477, 725.3363172696976, 14739.705205895822, 14762.48331308399, 14864.777028344584, 14896.776548351783, 14953.925230373887, 12598.874011259863, 12873.935630321788, 13088.738225235442, 13182.34088295591, 13230.536931207362, 11161.274517156358, 11448.71378215543, 11576.42117894102, 11634.592789252336, 11640.650780476599, 3814.809259537012, 3829.100161462054, 3854.498915141042, 3858.9614103858885, 3874.2638898609175, 52395.214071788956, 52707.209391859156, 53325.733371333285, 53837.0, 53871.92256154894, 10438.0, 10444.112250458797, 10532.473376331152, 10567.365958042543, 10601.098906593026, 19769.901150494155, 19771.0, 19826.801731982785, 19838.0, 19894.50263743418, 7746.845063098706, 7890.053193616803, 7898.052233731989, 8094.473859199134, 8388.916110838814, 4485.753283569435, 4560.6807523473035, 4569.428821397325, 4573.153966516205, 4592.954070459253, 3351.614564325085, 3371.190914180579, 3372.3929692655065, 3372.730181585467, 3376.2234686022352, 581.8632621333983, 597.2832600878876, 604.5526310530176, 606.8118883146238, 614.3089024847047, 597.9103134529769, 651.1242379000237, 691.02565382811, 699.867025265198, 723.2189235625511, 8386.916130838736, 8764.91235087641, 8806.647734090693, 8865.778355541162, 8974.910250897537, 525.5742848292895, 622.2657264427928, 642.3171291217042, 664.3323459922747, 672.5393105722497, 3964.484616999829, 4067.5322337930925, 4094.754314741125, 4125.91748165035, 4250.192463431938, 55474.0, 57218.0, 57314.7134264326, 57467.42532574704, 57535.71232143813, 49864.252036219485, 50020.74989625029, 50108.24837627439, 50115.49884501108, 51128.48871511312, 43913.0, 44840.55159448364, 44871.326930096075, 45388.546114539095, 46128.308075378896, 8172.713955011784, 8223.342132629496, 8279.0, 8526.190011948855, 8577.228049475327, 35013.0, 35369.646303537666, 36561.63438365582, 36565.45151822671, 37094.8145259272, 40206.59793402028, 40271.0, 42089.57910420857, 43190.352144717224, 43385.0, 10487.475626218811, 10511.10655594283, 10561.0, 10601.416922069051, 10744.62393816244, 11532.769344612892, 11586.188966772583, 11613.5354585819, 11675.065994720571, 12323.198992065487, 11509.366984815915, 11748.412579371168, 11780.882191178322, 11943.641690749291, 12094.45574949147, 11539.88460115388, 11540.134489913458, 11727.941360293144, 11753.647390578297, 12081.879181208076, 10631.521581528696, 11016.0, 11035.062019728091, 11888.108391870472, 11902.583409580624, 9442.197413219954, 9565.330426870052, 9871.309008369346, 9996.650117245861, 10030.398176109456, 9475.099865512766, 9600.75998100053, 9617.893942196737, 10085.29402941787, 10170.491475426052], "unit": "score", "name": "yui.html", "value": 6594.2220038631}], "name": "dromaeo_css", "value": 7359.556474624447}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 112.0, 110.0, 112.0, 124.0, 110.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [163.0, 133.0, 154.0, 168.0, 130.0, 152.0, 169.0, 130.0, 172.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.9}, {"lowerIsBetter": true, "replicates": [166.0, 165.0, 163.0, 164.0, 164.0, 162.0, 163.0, 163.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [75.0, 77.0, 76.0, 158.0, 73.0, 76.0, 72.0, 75.0, 167.0, 78.0], "unit": "score", "name": "audio-fft", "value": 92.7}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 137.0, 93.0, 93.0, 94.0, 145.0, 93.0, 93.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 116.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 55.0, 56.0, 55.0, 63.0, 55.0, 57.0, 66.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.3}, {"lowerIsBetter": true, "replicates": [79.0, 77.0, 80.0, 80.0, 81.0, 81.0, 80.0, 78.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.4}, {"lowerIsBetter": true, "replicates": [118.0, 119.0, 118.0, 115.0, 117.0, 124.0, 126.0, 115.0, 136.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [136.0, 153.0, 145.0, 149.0, 147.0, 135.0, 147.0, 145.0, 150.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.2}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 68.0, 69.0, 70.0, 69.0, 70.0, 68.0, 71.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1522.8}]} 17:05:36 INFO - Return code: 0 17:05:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:05:36 ERROR - # TBPL SUCCESS # 17:05:36 INFO - Running post-action listener: _resource_record_post_action 17:05:36 INFO - Running post-run listener: _resource_record_post_run 17:05:37 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 16384; Write bytes: 458309632; Read time: 36; Write time: 481732 17:05:37 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 0; Write bytes: 233938944; Read time: 0; Write time: 366156 17:05:37 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 16384; Write bytes: 219975680; Read time: 36; Write time: 114640 17:05:37 INFO - Running post-run listener: _upload_blobber_files 17:05:37 INFO - Blob upload gear active. 17:05:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:05:37 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 17:05:37 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'] 17:05:37 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 17:05:37 INFO - (blobuploader) - INFO - Open directory for files ... 17:05:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:05:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:05:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:38 INFO - (blobuploader) - INFO - Done attempting. 17:05:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:05:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:05:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:39 INFO - (blobuploader) - INFO - Done attempting. 17:05:39 INFO - (blobuploader) - INFO - Iteration through files over. 17:05:39 INFO - Return code: 0 17:05:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:05:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:05:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63b282e62f4c4337e3013f7f862a17ebcd63199ff157150e4f86347d4711c9500e4720f5a11e6a83373647e7c302aa8a457c80a38371eba01c2d96d3628099af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc2566043ff2a61b7587e03d6252dca41e0dbc516a52dc8977cceaca292fcd5dff3a872aaad0de19c46dfb2f9fb5a97bc11fba6eff0b5d617ead8d23ed0507c8"} 17:05:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:05:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:05:39 INFO - Contents: 17:05:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63b282e62f4c4337e3013f7f862a17ebcd63199ff157150e4f86347d4711c9500e4720f5a11e6a83373647e7c302aa8a457c80a38371eba01c2d96d3628099af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc2566043ff2a61b7587e03d6252dca41e0dbc516a52dc8977cceaca292fcd5dff3a872aaad0de19c46dfb2f9fb5a97bc11fba6eff0b5d617ead8d23ed0507c8"} 17:05:39 INFO - Running post-run listener: copy_logs_to_upload_dir 17:05:39 INFO - Copying logs to upload dir... 17:05:39 INFO - mkdir: /builds/slave/test/build/upload/logs 17:05:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.049202 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-06-02 17:05:39.168048) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 17:05:39.171978) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757 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/63b282e62f4c4337e3013f7f862a17ebcd63199ff157150e4f86347d4711c9500e4720f5a11e6a83373647e7c302aa8a457c80a38371eba01c2d96d3628099af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc2566043ff2a61b7587e03d6252dca41e0dbc516a52dc8977cceaca292fcd5dff3a872aaad0de19c46dfb2f9fb5a97bc11fba6eff0b5d617ead8d23ed0507c8"} build_url:https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/Gc0Yx5e4QHCbVdvLiy2A0g/artifacts/public/build/firefox-47.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/63b282e62f4c4337e3013f7f862a17ebcd63199ff157150e4f86347d4711c9500e4720f5a11e6a83373647e7c302aa8a457c80a38371eba01c2d96d3628099af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc2566043ff2a61b7587e03d6252dca41e0dbc516a52dc8977cceaca292fcd5dff3a872aaad0de19c46dfb2f9fb5a97bc11fba6eff0b5d617ead8d23ed0507c8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 17:05:39.198331) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 17:05:39.198681) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464910749.110266-209214757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 17:05:39.280382) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 17:05:39.280740) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 17:05:39.281033) ========= ========= Total master_lag: 0.38 =========