builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-040 starttime: 1462550982.5 results: success (0) buildid: 20160506063418 builduid: 101946d3d6c1492cb9298cdbcff7f8e9 revision: f485ca11d5d597330094223dd9cc9dfa035f7ab3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 09:09:42.502752) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 09:09:42.503705) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 09:09:42.504402) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 09:09:42.540834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:09:42.541221) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 09:09:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-05-06 09:09:43 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126813 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:09:42.683275) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:09:42.683607) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023243 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:09:42.741361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:09:42.741719) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f485ca11d5d597330094223dd9cc9dfa035f7ab3 --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 f485ca11d5d597330094223dd9cc9dfa035f7ab3 --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=9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 09:09:43,577 truncating revision to first 12 chars 2016-05-06 09:09:43,577 Setting DEBUG logging. 2016-05-06 09:09:43,577 attempt 1/10 2016-05-06 09:09:43,577 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f485ca11d5d5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 09:09:43,844 unpacking tar archive at: mozilla-beta-f485ca11d5d5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.524935 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:09:43.284723) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 09:09:43.285045) ========= script_repo_revision: f485ca11d5d597330094223dd9cc9dfa035f7ab3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 09:09:43.285460) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 09:09:43.285819) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 09:09:43.302342) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-06 09:09:43.302642) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:09:44 INFO - MultiFileLogger online at 20160506 09:09:44 in /builds/slave/test 09:09:44 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 09:09:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:09:44 INFO - {'append_to_log': False, 09:09:44 INFO - 'base_work_dir': '/builds/slave/test', 09:09:44 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:09:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:09:44 INFO - 'branch': 'Mozilla-Beta', 09:09:44 INFO - 'buildbot_json_path': 'buildprops.json', 09:09:44 INFO - 'config_files': ('talos/linux_config.py',), 09:09:44 INFO - 'default_actions': ('clobber', 09:09:44 INFO - 'read-buildbot-config', 09:09:44 INFO - 'download-and-extract', 09:09:44 INFO - 'populate-webroot', 09:09:44 INFO - 'create-virtualenv', 09:09:44 INFO - 'install', 09:09:44 INFO - 'run-tests'), 09:09:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:09:44 INFO - 'download_minidump_stackwalk': True, 09:09:44 INFO - 'download_symbols': 'ondemand', 09:09:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:09:44 INFO - 'tooltool.py': '/tools/tooltool.py', 09:09:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:09:44 INFO - '/tools/misc-python/virtualenv.py')}, 09:09:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:09:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:09:44 INFO - 'installer_path': 'installer.exe', 09:09:44 INFO - 'log_level': 'info', 09:09:44 INFO - 'log_name': 'talos', 09:09:44 INFO - 'log_to_console': True, 09:09:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:09:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:09:44 INFO - 'opt_config_files': (), 09:09:44 INFO - 'pip_index': False, 09:09:44 INFO - 'sps_profile': False, 09:09:44 INFO - 'sps_profile_interval': 0, 09:09:44 INFO - 'suite': 'dromaeojs-e10s', 09:09:44 INFO - 'system_bits': '32', 09:09:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:09:44 INFO - 'title': 'talos-linux64-ix-040', 09:09:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:09:44 INFO - 'use_talos_json': True, 09:09:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:09:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:09:44 INFO - 'work_dir': 'build'} 09:09:44 INFO - ##### 09:09:44 INFO - ##### Running clobber step. 09:09:44 INFO - ##### 09:09:44 INFO - Running pre-action listener: _resource_record_pre_action 09:09:44 INFO - Running main action method: clobber 09:09:44 INFO - rmtree: /builds/slave/test/build 09:09:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:09:44 INFO - Running post-action listener: _resource_record_post_action 09:09:44 INFO - ##### 09:09:44 INFO - ##### Running read-buildbot-config step. 09:09:44 INFO - ##### 09:09:44 INFO - Running pre-action listener: _resource_record_pre_action 09:09:44 INFO - Running main action method: read_buildbot_config 09:09:44 INFO - Using buildbot properties: 09:09:44 INFO - { 09:09:44 INFO - "project": "", 09:09:44 INFO - "product": "firefox", 09:09:44 INFO - "script_repo_revision": "production", 09:09:44 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 09:09:44 INFO - "repository": "", 09:09:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 09:09:44 INFO - "buildid": "20160506063418", 09:09:44 INFO - "pgo_build": "True", 09:09:44 INFO - "basedir": "/builds/slave/test", 09:09:44 INFO - "buildnumber": 83, 09:09:44 INFO - "slavename": "talos-linux64-ix-040", 09:09:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:09:44 INFO - "platform": "ubuntu64_hw", 09:09:44 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:09:44 INFO - "branch": "mozilla-beta", 09:09:44 INFO - "repo_path": "releases/mozilla-beta", 09:09:44 INFO - "revision": "f485ca11d5d597330094223dd9cc9dfa035f7ab3", 09:09:44 INFO - "stage_platform": "linux64-pgo", 09:09:44 INFO - "builduid": "101946d3d6c1492cb9298cdbcff7f8e9", 09:09:44 INFO - "slavebuilddir": "test" 09:09:44 INFO - } 09:09:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 09:09:44 INFO - Running post-action listener: _resource_record_post_action 09:09:44 INFO - ##### 09:09:44 INFO - ##### Running download-and-extract step. 09:09:44 INFO - ##### 09:09:44 INFO - Running pre-action listener: _resource_record_pre_action 09:09:44 INFO - Running main action method: download_and_extract 09:09:44 INFO - mkdir: /builds/slave/test/build/tests 09:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:44 INFO - https://queue.taskcluster.net/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:09:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:09:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:09:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/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 09:09:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/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 09:09:48 INFO - Downloaded 1412 bytes. 09:09:48 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:09:48 INFO - Using the following test package requirements: 09:09:48 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:09:48 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:09:48 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:09:48 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:09:48 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 09:09:48 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:09:48 INFO - u'jsshell-linux-x86_64.zip'], 09:09:48 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:09:48 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:09:48 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:09:48 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:09:48 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 09:09:48 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:09:48 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 09:09:48 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:09:48 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:09:48 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:09:48 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:09:48 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:09:48 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:09: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')]} 09:09:48 INFO - https://queue.taskcluster.net/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:09:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:09:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:09:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/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 09:09:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/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 09:09:59 INFO - Downloaded 23364678 bytes. 09:09:59 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'] 09:09:59 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 09:10:00 INFO - Return code: 0 09:10:00 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 09:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:00 INFO - https://queue.taskcluster.net/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:10:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:10:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:10:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/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 09:10:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/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 09:10:02 INFO - Downloaded 23364678 bytes. 09:10:02 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'] 09:10:02 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 09:10:03 INFO - Return code: 0 09:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:03 INFO - https://queue.taskcluster.net/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:10:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 09:10:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 09:10:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/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 09:10:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/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 09:10:04 INFO - Downloaded 10845194 bytes. 09:10:04 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'] 09:10:04 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 09:10:05 INFO - Return code: 0 09:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:05 INFO - https://queue.taskcluster.net/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:10:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:10:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:10:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/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 09:10:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/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 09:10:06 INFO - Downloaded 53799373 bytes. 09:10:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:10:06 INFO - mkdir: /builds/slave/test/properties 09:10:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:10:06 INFO - Writing to file /builds/slave/test/properties/build_url 09:10:06 INFO - Contents: 09:10:06 INFO - build_url:https://queue.taskcluster.net/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:10:07 INFO - Running post-action listener: _resource_record_post_action 09:10:07 INFO - Running post-action listener: set_extra_try_arguments 09:10:07 INFO - ##### 09:10:07 INFO - ##### Running populate-webroot step. 09:10:07 INFO - ##### 09:10:07 INFO - Running pre-action listener: _resource_record_pre_action 09:10:07 INFO - Running main action method: populate_webroot 09:10:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:10:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:10:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:10:07 INFO - '--tppagecycles', 09:10:07 INFO - '7'], 09:10:07 INFO - 'tests': ['tsvgm']}}, 09:10:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:10:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:10:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:10:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:10:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:10:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:10:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:10:07 INFO - 'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:10:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:10:07 INFO - 'tests': ['damp', 'tps']}, 09:10:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:10:07 INFO - 'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['damp', 'tps']}, 09:10:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:10:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:10:07 INFO - 'other': {'tests': ['a11yr', 09:10:07 INFO - 'ts_paint', 09:10:07 INFO - 'tpaint', 09:10:07 INFO - 'sessionrestore', 09:10:07 INFO - 'sessionrestore_no_auto_restore', 09:10:07 INFO - 'tabpaint']}, 09:10:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['a11yr', 09:10:07 INFO - 'ts_paint', 09:10:07 INFO - 'tpaint', 09:10:07 INFO - 'sessionrestore', 09:10:07 INFO - 'sessionrestore_no_auto_restore', 09:10:07 INFO - 'tabpaint']}, 09:10:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['a11yr', 09:10:07 INFO - 'ts_paint', 09:10:07 INFO - 'tpaint', 09:10:07 INFO - 'sessionrestore', 09:10:07 INFO - 'sessionrestore_no_auto_restore', 09:10:07 INFO - 'tabpaint']}, 09:10:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['a11yr', 09:10:07 INFO - 'ts_paint', 09:10:07 INFO - 'tpaint', 09:10:07 INFO - 'sessionrestore', 09:10:07 INFO - 'sessionrestore_no_auto_restore', 09:10:07 INFO - 'tabpaint']}, 09:10:07 INFO - 'other_l64': {'tests': ['a11yr', 09:10:07 INFO - 'ts_paint', 09:10:07 INFO - 'tpaint', 09:10:07 INFO - 'sessionrestore', 09:10:07 INFO - 'sessionrestore_no_auto_restore', 09:10:07 INFO - 'tabpaint']}, 09:10:07 INFO - 'other_nol64': {'tests': ['a11yr', 09:10:07 INFO - 'ts_paint', 09:10:07 INFO - 'tpaint', 09:10:07 INFO - 'sessionrestore', 09:10:07 INFO - 'sessionrestore_no_auto_restore', 09:10:07 INFO - 'tabpaint']}, 09:10:07 INFO - 'svgr': {'tests': ['tsvgx', 09:10:07 INFO - 'tsvgr_opacity', 09:10:07 INFO - 'tart', 09:10:07 INFO - 'tscrollx', 09:10:07 INFO - 'cart']}, 09:10:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['tsvgx', 09:10:07 INFO - 'tsvgr_opacity', 09:10:07 INFO - 'tart', 09:10:07 INFO - 'tscrollx', 09:10:07 INFO - 'cart']}, 09:10:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:10:07 INFO - 'tests': ['tp5o']}, 09:10:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:10:07 INFO - 'talos_options': ['--e10s'], 09:10:07 INFO - 'tests': ['tp5o']}, 09:10:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:10:07 INFO - 'talos_options': ['--xperf_path', 09:10:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:10:07 INFO - 'tests': ['tp5n']}, 09:10:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:10:07 INFO - 'talos_options': ['--e10s', 09:10:07 INFO - '--xperf_path', 09:10:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:10:07 INFO - 'tests': ['tp5n']}}, 09:10:07 INFO - 'talos.zip': {'path': '', 09:10:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:10:07 INFO - Running post-action listener: _resource_record_post_action 09:10:07 INFO - ##### 09:10:07 INFO - ##### Running create-virtualenv step. 09:10:07 INFO - ##### 09:10:07 INFO - Running pre-action listener: _resource_record_pre_action 09:10:07 INFO - Running main action method: create_virtualenv 09:10:07 INFO - Creating virtualenv /builds/slave/test/build/venv 09:10:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:10:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:10:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:10:07 INFO - Using real prefix '/usr' 09:10:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:10:08 INFO - Installing distribute.............................................................................................................................................................................................done. 09:10:10 INFO - Installing pip.................done. 09:10:10 INFO - Return code: 0 09:10:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:10 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 0x7f4b0999ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c06160>, '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 0x1c07060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c074f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:10:10 INFO - Using env: {'DISPLAY': ':0', 09:10:10 INFO - 'HOME': '/home/cltbld', 09:10:10 INFO - 'LANG': 'en_US.UTF-8', 09:10:10 INFO - 'LANGUAGE': 'en_US:en', 09:10:10 INFO - 'LOGNAME': 'cltbld', 09:10:10 INFO - 'MAIL': '/var/mail/cltbld', 09:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:10 INFO - 'MOZ_NO_REMOTE': '1', 09:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:10 INFO - 'NO_EM_RESTART': '1', 09:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:10 INFO - 'PWD': '/builds/slave/test', 09:10:10 INFO - 'SHELL': '/bin/bash', 09:10:10 INFO - 'SHLVL': '1', 09:10:10 INFO - 'TERM': 'linux', 09:10:10 INFO - 'TMOUT': '86400', 09:10:10 INFO - 'USER': 'cltbld', 09:10:10 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 09:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:10 INFO - '_': '/tools/buildbot/bin/python'} 09:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:10:10 INFO - Cleaning up... 09:10:10 INFO - Return code: 0 09:10:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:10 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 0x7f4b0999ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c06160>, '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 0x1c07060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c074f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:10:10 INFO - Using env: {'DISPLAY': ':0', 09:10:10 INFO - 'HOME': '/home/cltbld', 09:10:10 INFO - 'LANG': 'en_US.UTF-8', 09:10:10 INFO - 'LANGUAGE': 'en_US:en', 09:10:10 INFO - 'LOGNAME': 'cltbld', 09:10:10 INFO - 'MAIL': '/var/mail/cltbld', 09:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:10 INFO - 'MOZ_NO_REMOTE': '1', 09:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:10 INFO - 'NO_EM_RESTART': '1', 09:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:10 INFO - 'PWD': '/builds/slave/test', 09:10:10 INFO - 'SHELL': '/bin/bash', 09:10:10 INFO - 'SHLVL': '1', 09:10:10 INFO - 'TERM': 'linux', 09:10:10 INFO - 'TMOUT': '86400', 09:10:10 INFO - 'USER': 'cltbld', 09:10:10 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 09:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:10 INFO - '_': '/tools/buildbot/bin/python'} 09:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:10 INFO - Downloading/unpacking psutil>=0.7.1 09:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:10:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:10:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:10:12 INFO - Installing collected packages: psutil 09:10:12 INFO - Running setup.py install for psutil 09:10:12 INFO - building 'psutil._psutil_linux' extension 09:10:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:10:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:10:12 INFO - building 'psutil._psutil_posix' extension 09:10:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:10:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:10:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:10:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:10:12 INFO - Successfully installed psutil 09:10:12 INFO - Cleaning up... 09:10:13 INFO - Return code: 0 09:10:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:13 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 0x7f4b0999ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c06160>, '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 0x1c07060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c074f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:10:13 INFO - Using env: {'DISPLAY': ':0', 09:10:13 INFO - 'HOME': '/home/cltbld', 09:10:13 INFO - 'LANG': 'en_US.UTF-8', 09:10:13 INFO - 'LANGUAGE': 'en_US:en', 09:10:13 INFO - 'LOGNAME': 'cltbld', 09:10:13 INFO - 'MAIL': '/var/mail/cltbld', 09:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:13 INFO - 'MOZ_NO_REMOTE': '1', 09:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:13 INFO - 'NO_EM_RESTART': '1', 09:10:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:13 INFO - 'PWD': '/builds/slave/test', 09:10:13 INFO - 'SHELL': '/bin/bash', 09:10:13 INFO - 'SHLVL': '1', 09:10:13 INFO - 'TERM': 'linux', 09:10:13 INFO - 'TMOUT': '86400', 09:10:13 INFO - 'USER': 'cltbld', 09:10:13 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 09:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:13 INFO - '_': '/tools/buildbot/bin/python'} 09:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:10:15 INFO - Installing collected packages: mozsystemmonitor 09:10:15 INFO - Running setup.py install for mozsystemmonitor 09:10:15 INFO - Successfully installed mozsystemmonitor 09:10:15 INFO - Cleaning up... 09:10:15 INFO - Return code: 0 09:10:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:15 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 0x7f4b0999ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c06160>, '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 0x1c07060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c074f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:10:15 INFO - Using env: {'DISPLAY': ':0', 09:10:15 INFO - 'HOME': '/home/cltbld', 09:10:15 INFO - 'LANG': 'en_US.UTF-8', 09:10:15 INFO - 'LANGUAGE': 'en_US:en', 09:10:15 INFO - 'LOGNAME': 'cltbld', 09:10:15 INFO - 'MAIL': '/var/mail/cltbld', 09:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:15 INFO - 'MOZ_NO_REMOTE': '1', 09:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:15 INFO - 'NO_EM_RESTART': '1', 09:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:15 INFO - 'PWD': '/builds/slave/test', 09:10:15 INFO - 'SHELL': '/bin/bash', 09:10:15 INFO - 'SHLVL': '1', 09:10:15 INFO - 'TERM': 'linux', 09:10:15 INFO - 'TMOUT': '86400', 09:10:15 INFO - 'USER': 'cltbld', 09:10:15 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 09:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:15 INFO - '_': '/tools/buildbot/bin/python'} 09:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:15 INFO - Downloading/unpacking blobuploader==1.2.4 09:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:17 INFO - Downloading blobuploader-1.2.4.tar.gz 09:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:10:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:10:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:18 INFO - Downloading docopt-0.6.1.tar.gz 09:10:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:10:18 INFO - Installing collected packages: blobuploader, requests, docopt 09:10:18 INFO - Running setup.py install for blobuploader 09:10:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:10:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:10:18 INFO - Running setup.py install for requests 09:10:18 INFO - Running setup.py install for docopt 09:10:18 INFO - Successfully installed blobuploader requests docopt 09:10:18 INFO - Cleaning up... 09:10:18 INFO - Return code: 0 09:10:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:18 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 0x7f4b0999ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c06160>, '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 0x1c07060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c074f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:10:18 INFO - Using env: {'DISPLAY': ':0', 09:10:18 INFO - 'HOME': '/home/cltbld', 09:10:18 INFO - 'LANG': 'en_US.UTF-8', 09:10:18 INFO - 'LANGUAGE': 'en_US:en', 09:10:18 INFO - 'LOGNAME': 'cltbld', 09:10:18 INFO - 'MAIL': '/var/mail/cltbld', 09:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:18 INFO - 'MOZ_NO_REMOTE': '1', 09:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:18 INFO - 'NO_EM_RESTART': '1', 09:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:18 INFO - 'PWD': '/builds/slave/test', 09:10:18 INFO - 'SHELL': '/bin/bash', 09:10:18 INFO - 'SHLVL': '1', 09:10:18 INFO - 'TERM': 'linux', 09:10:18 INFO - 'TMOUT': '86400', 09:10:18 INFO - 'USER': 'cltbld', 09:10:18 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 09:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:18 INFO - '_': '/tools/buildbot/bin/python'} 09:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:10:18 INFO - Running setup.py (path:/tmp/pip-9L68FM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:10:19 INFO - Running setup.py (path:/tmp/pip-PM8Fyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:10:19 INFO - Running setup.py (path:/tmp/pip-gyMmm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:10:19 INFO - Running setup.py (path:/tmp/pip-gxTgqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:10:19 INFO - Running setup.py (path:/tmp/pip-S9U3dH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:10:19 INFO - Running setup.py (path:/tmp/pip-JnHBNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:10:19 INFO - Running setup.py (path:/tmp/pip-YskCgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:10:19 INFO - Running setup.py (path:/tmp/pip-oRMgy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:10:19 INFO - Running setup.py (path:/tmp/pip-MVSHlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:10:19 INFO - Running setup.py (path:/tmp/pip-fevliP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:10:19 INFO - Running setup.py (path:/tmp/pip-_kZkx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:10:19 INFO - Running setup.py (path:/tmp/pip-KKr9hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:10:19 INFO - Running setup.py (path:/tmp/pip-bb642y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:10:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:10:19 INFO - Running setup.py (path:/tmp/pip-28_9x2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:20 INFO - Running setup.py (path:/tmp/pip-4xMJke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:10:20 INFO - Running setup.py (path:/tmp/pip-it7jHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:10:20 INFO - Running setup.py (path:/tmp/pip-B3Hnvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:10:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:10:20 INFO - Running setup.py install for manifestparser 09:10:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:10:20 INFO - Running setup.py install for mozcrash 09:10:20 INFO - Running setup.py install for mozdebug 09:10:20 INFO - Running setup.py install for mozdevice 09:10:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:10:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:10:20 INFO - Running setup.py install for mozfile 09:10:20 INFO - Running setup.py install for mozhttpd 09:10:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:10:20 INFO - Running setup.py install for mozinfo 09:10:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:10:20 INFO - Running setup.py install for mozInstall 09:10:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:10:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:10:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:10:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:10:21 INFO - Running setup.py install for mozleak 09:10:21 INFO - Running setup.py install for mozlog 09:10:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:10:21 INFO - Running setup.py install for moznetwork 09:10:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:10:21 INFO - Running setup.py install for mozprocess 09:10:21 INFO - Running setup.py install for mozprofile 09:10:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:10:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:10:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:10:21 INFO - Running setup.py install for mozrunner 09:10:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:10:21 INFO - Running setup.py install for mozscreenshot 09:10:21 INFO - Running setup.py install for moztest 09:10:21 INFO - Running setup.py install for mozversion 09:10:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:10:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:10:21 INFO - Cleaning up... 09:10:22 INFO - Return code: 0 09:10:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:22 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 0x7f4b0999ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c06160>, '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 0x1c07060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c074f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:10:22 INFO - Using env: {'DISPLAY': ':0', 09:10:22 INFO - 'HOME': '/home/cltbld', 09:10:22 INFO - 'LANG': 'en_US.UTF-8', 09:10:22 INFO - 'LANGUAGE': 'en_US:en', 09:10:22 INFO - 'LOGNAME': 'cltbld', 09:10:22 INFO - 'MAIL': '/var/mail/cltbld', 09:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:22 INFO - 'MOZ_NO_REMOTE': '1', 09:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:22 INFO - 'NO_EM_RESTART': '1', 09:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:22 INFO - 'PWD': '/builds/slave/test', 09:10:22 INFO - 'SHELL': '/bin/bash', 09:10:22 INFO - 'SHLVL': '1', 09:10:22 INFO - 'TERM': 'linux', 09:10:22 INFO - 'TMOUT': '86400', 09:10:22 INFO - 'USER': 'cltbld', 09:10:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 09:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:22 INFO - '_': '/tools/buildbot/bin/python'} 09:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:10:22 INFO - Running setup.py (path:/tmp/pip-sKuXm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:10:22 INFO - Running setup.py (path:/tmp/pip-i3AJPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:10:22 INFO - Running setup.py (path:/tmp/pip-4Cqoo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:10:22 INFO - Running setup.py (path:/tmp/pip-romfRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:10:22 INFO - Running setup.py (path:/tmp/pip-R_fRtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:10:22 INFO - Running setup.py (path:/tmp/pip-3122gJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:10:22 INFO - Running setup.py (path:/tmp/pip-6_YKSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:10:22 INFO - Running setup.py (path:/tmp/pip-a0wyS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:10:22 INFO - Running setup.py (path:/tmp/pip-ah0f3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:10:22 INFO - Running setup.py (path:/tmp/pip-YJ4kD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:10:22 INFO - Running setup.py (path:/tmp/pip-xL0jcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:10:23 INFO - Running setup.py (path:/tmp/pip-sw3Haa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:10:23 INFO - Running setup.py (path:/tmp/pip-iehUsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:10:23 INFO - Running setup.py (path:/tmp/pip-lXqo5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:23 INFO - Running setup.py (path:/tmp/pip-cvZhnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:10:23 INFO - Running setup.py (path:/tmp/pip-5WHRC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:10:23 INFO - Running setup.py (path:/tmp/pip-6YnTew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:10:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:25 INFO - Downloading blessings-1.6.tar.gz 09:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:10:25 INFO - Installing collected packages: blessings 09:10:25 INFO - Running setup.py install for blessings 09:10:25 INFO - Successfully installed blessings 09:10:25 INFO - Cleaning up... 09:10:25 INFO - Return code: 0 09:10:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:10:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:10:25 INFO - Reading from file tmpfile_stdout 09:10:25 INFO - Current package versions: 09:10:25 INFO - argparse == 1.2.1 09:10:25 INFO - blessings == 1.6 09:10:25 INFO - blobuploader == 1.2.4 09:10:25 INFO - docopt == 0.6.1 09:10:25 INFO - manifestparser == 1.1 09:10:25 INFO - mozInstall == 1.12 09:10:25 INFO - mozcrash == 0.17 09:10:25 INFO - mozdebug == 0.1 09:10:25 INFO - mozdevice == 0.48 09:10:25 INFO - mozfile == 1.2 09:10:25 INFO - mozhttpd == 0.7 09:10:25 INFO - mozinfo == 0.9 09:10:25 INFO - mozleak == 0.1 09:10:25 INFO - mozlog == 3.1 09:10:25 INFO - moznetwork == 0.27 09:10:25 INFO - mozprocess == 0.22 09:10:25 INFO - mozprofile == 0.28 09:10:25 INFO - mozrunner == 6.11 09:10:25 INFO - mozscreenshot == 0.1 09:10:25 INFO - mozsystemmonitor == 0.0 09:10:25 INFO - moztest == 0.7 09:10:25 INFO - mozversion == 1.4 09:10:25 INFO - psutil == 3.1.1 09:10:25 INFO - requests == 1.2.3 09:10:25 INFO - wsgiref == 0.1.2 09:10:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:25 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 0x7f4b0999ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c06160>, '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 0x1c07060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c074f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:10:25 INFO - Using env: {'DISPLAY': ':0', 09:10:25 INFO - 'HOME': '/home/cltbld', 09:10:25 INFO - 'LANG': 'en_US.UTF-8', 09:10:25 INFO - 'LANGUAGE': 'en_US:en', 09:10:25 INFO - 'LOGNAME': 'cltbld', 09:10:25 INFO - 'MAIL': '/var/mail/cltbld', 09:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:25 INFO - 'MOZ_NO_REMOTE': '1', 09:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:25 INFO - 'NO_EM_RESTART': '1', 09:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:25 INFO - 'PWD': '/builds/slave/test', 09:10:25 INFO - 'SHELL': '/bin/bash', 09:10:25 INFO - 'SHLVL': '1', 09:10:25 INFO - 'TERM': 'linux', 09:10:25 INFO - 'TMOUT': '86400', 09:10:25 INFO - 'USER': 'cltbld', 09:10:25 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 09:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:25 INFO - '_': '/tools/buildbot/bin/python'} 09:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:10:25 INFO - Cleaning up... 09:10:26 INFO - Return code: 0 09:10:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:26 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 0x7f4b0999ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c06160>, '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 0x1c07060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c074f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:10:26 INFO - Using env: {'DISPLAY': ':0', 09:10:26 INFO - 'HOME': '/home/cltbld', 09:10:26 INFO - 'LANG': 'en_US.UTF-8', 09:10:26 INFO - 'LANGUAGE': 'en_US:en', 09:10:26 INFO - 'LOGNAME': 'cltbld', 09:10:26 INFO - 'MAIL': '/var/mail/cltbld', 09:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:26 INFO - 'MOZ_NO_REMOTE': '1', 09:10:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:26 INFO - 'NO_EM_RESTART': '1', 09:10:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:26 INFO - 'PWD': '/builds/slave/test', 09:10:26 INFO - 'SHELL': '/bin/bash', 09:10:26 INFO - 'SHLVL': '1', 09:10:26 INFO - 'TERM': 'linux', 09:10:26 INFO - 'TMOUT': '86400', 09:10:26 INFO - 'USER': 'cltbld', 09:10:26 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 09:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:26 INFO - '_': '/tools/buildbot/bin/python'} 09:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:26 INFO - Downloading/unpacking jsonschema 09:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:10:28 INFO - Downloading/unpacking functools32 (from jsonschema) 09:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:28 INFO - Downloading functools32-3.2.3-2.tar.gz 09:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:10:28 INFO - warning: no files found matching '*.txt' 09:10:28 INFO - no previously-included directories found matching 'build' 09:10:28 INFO - no previously-included directories found matching 'dist' 09:10:28 INFO - no previously-included directories found matching '.git*' 09:10:28 INFO - Installing collected packages: jsonschema, functools32 09:10:28 INFO - Running setup.py install for functools32 09:10:28 INFO - warning: no files found matching '*.txt' 09:10:28 INFO - no previously-included directories found matching 'build' 09:10:28 INFO - no previously-included directories found matching 'dist' 09:10:28 INFO - no previously-included directories found matching '.git*' 09:10:28 INFO - Successfully installed jsonschema functools32 09:10:28 INFO - Cleaning up... 09:10:28 INFO - Return code: 0 09:10:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:28 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 0x7f4b0999ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c06160>, '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 0x1c07060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c074f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:10:28 INFO - Using env: {'DISPLAY': ':0', 09:10:28 INFO - 'HOME': '/home/cltbld', 09:10:28 INFO - 'LANG': 'en_US.UTF-8', 09:10:28 INFO - 'LANGUAGE': 'en_US:en', 09:10:28 INFO - 'LOGNAME': 'cltbld', 09:10:28 INFO - 'MAIL': '/var/mail/cltbld', 09:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:28 INFO - 'MOZ_NO_REMOTE': '1', 09:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:28 INFO - 'NO_EM_RESTART': '1', 09:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:28 INFO - 'PWD': '/builds/slave/test', 09:10:28 INFO - 'SHELL': '/bin/bash', 09:10:28 INFO - 'SHLVL': '1', 09:10:28 INFO - 'TERM': 'linux', 09:10:28 INFO - 'TMOUT': '86400', 09:10:28 INFO - 'USER': 'cltbld', 09:10:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 09:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:28 INFO - '_': '/tools/buildbot/bin/python'} 09:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:28 INFO - Downloading/unpacking flake8 09:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:10:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:10: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 09:10: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 09:10: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 09:10: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 09:10: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 09:10: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 09:10:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:10:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:10: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 09:10: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 09:10: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 09:10: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 09:10: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 09:10: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 09:10:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:10:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:10:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:10:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:10:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:10:31 INFO - no previously-included directories found matching 'docs/_build' 09:10:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:10:31 INFO - Running setup.py install for pep8 09:10:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:10:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:10:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:10:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:10:31 INFO - no previously-included directories found matching 'docs/_build' 09:10:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:10:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:10:31 INFO - Cleaning up... 09:10:31 INFO - Return code: 0 09:10:31 INFO - Running post-action listener: _resource_record_post_action 09:10:31 INFO - Running post-action listener: _start_resource_monitoring 09:10:31 INFO - Starting resource monitoring. 09:10:31 INFO - ##### 09:10:31 INFO - ##### Running install step. 09:10:31 INFO - ##### 09:10:31 INFO - Running pre-action listener: _resource_record_pre_action 09:10:31 INFO - Running main action method: install 09:10:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:10:31 INFO - Reading from file tmpfile_stdout 09:10:31 INFO - Detecting whether we're running mozinstall >=1.0... 09:10:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:10:31 INFO - Reading from file tmpfile_stdout 09:10:31 INFO - Output received: 09:10:31 INFO - Usage: mozinstall [options] installer 09:10:31 INFO - Options: 09:10:31 INFO - -h, --help show this help message and exit 09:10:31 INFO - -d DEST, --destination=DEST 09:10:31 INFO - Directory to install application into. [default: 09:10:31 INFO - "/builds/slave/test"] 09:10:31 INFO - --app=APP Application being installed. [default: firefox] 09:10:31 INFO - mkdir: /builds/slave/test/build/application 09:10:31 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'] 09:10:31 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 09:10:44 INFO - Reading from file tmpfile_stdout 09:10:44 INFO - Output received: 09:10:44 INFO - /builds/slave/test/build/application/firefox/firefox 09:10:44 INFO - Running post-action listener: _resource_record_post_action 09:10:44 INFO - ##### 09:10:44 INFO - ##### Running run-tests step. 09:10:44 INFO - ##### 09:10:44 INFO - Running pre-action listener: _resource_record_pre_action 09:10:44 INFO - Running main action method: run_tests 09:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:10:44 INFO - Python 2.7.3 09:10:44 INFO - Return code: 0 09:10:44 INFO - grabbing minidump binary from tooltool 09:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:44 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 0x1c06160>, '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 0x1c07060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c074f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:10:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:10:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:10:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:10:44 INFO - Return code: 0 09:10:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:10:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:10:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:10:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:10:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:10:45 INFO - Return code: 0 09:10:45 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/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:10:45 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/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:10:45 INFO - Using env: {'DISPLAY': ':0', 09:10:45 INFO - 'HOME': '/home/cltbld', 09:10:45 INFO - 'LANG': 'en_US.UTF-8', 09:10:45 INFO - 'LANGUAGE': 'en_US:en', 09:10:45 INFO - 'LOGNAME': 'cltbld', 09:10:45 INFO - 'MAIL': '/var/mail/cltbld', 09:10:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:10:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:45 INFO - 'MOZ_NO_REMOTE': '1', 09:10:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:10:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:45 INFO - 'NO_EM_RESTART': '1', 09:10:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:45 INFO - 'PWD': '/builds/slave/test', 09:10:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:10:45 INFO - 'SHELL': '/bin/bash', 09:10:45 INFO - 'SHLVL': '1', 09:10:45 INFO - 'TERM': 'linux', 09:10:45 INFO - 'TMOUT': '86400', 09:10:45 INFO - 'USER': 'cltbld', 09:10:45 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989', 09:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:45 INFO - '_': '/tools/buildbot/bin/python'} 09:10:45 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/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:10:45 INFO - mozversion application_buildid: 20160506063418 09:10:45 INFO - mozversion application_changeset: f485ca11d5d597330094223dd9cc9dfa035f7ab3 09:10:45 INFO - mozversion application_display_name: Firefox 09:10:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:10:45 INFO - mozversion application_name: Firefox 09:10:45 INFO - mozversion application_remotingname: firefox 09:10:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:10:45 INFO - mozversion application_vendor: Mozilla 09:10:45 INFO - mozversion application_version: 47.0 09:10:45 INFO - mozversion platform_buildid: 20160506063418 09:10:45 INFO - mozversion platform_changeset: f485ca11d5d597330094223dd9cc9dfa035f7ab3 09:10:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:10:45 INFO - mozversion platform_version: 47.0 09:10:45 INFO - using testdate: 1462551045 09:10:45 INFO - actual date: 1462551045 09:10:45 INFO - starting webserver on 'localhost:52270' 09:10:45 INFO - SUITE-START | Running 2 tests 09:10:45 INFO - TEST-START | dromaeo_css 09:10:45 INFO - operating with platform_type : linux_ 09:10:45 INFO - Initialising browser for dromaeo_css test... 09:10:45 INFO - TEST-INFO | started process 21485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG7Tv4E/profile http://localhost:52270/getInfo.html) 09:10:49 INFO - PROCESS | 21485 | 09:10:49 INFO - PROCESS | 21485 | (process:21562): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:10:50 INFO - PROCESS | 21485 | __metrics Screen width/height:1600/1200 09:10:50 INFO - PROCESS | 21485 | colorDepth:24 09:10:50 INFO - PROCESS | 21485 | Browser inner width/height: 1024/697 09:10:50 INFO - PROCESS | 21485 | __metrics 09:10:50 ERROR - PROCESS | 21485 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:10:51 INFO - TEST-INFO | 21485: exit 0 09:10:51 INFO - Browser initialized. 09:10:51 INFO - Running cycle 1/1 for dromaeo_css test... 09:10:51 INFO - TEST-INFO | started process 21612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG7Tv4E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:10:53 INFO - PROCESS | 21612 | 09:10:53 INFO - PROCESS | 21612 | (process:21681): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:11:03 INFO - PROCESS | 21612 | RSS: Main: 149168128 09:11:03 INFO - PROCESS | 21612 | 09:11:53 INFO - PROCESS | 21612 | 1462551113212 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:14:00 INFO - PROCESS | 21612 | Cycle 1(1): loaded http://localhost:52270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52270/tests/dromaeo/cssquery-ext.html) 09:14:01 INFO - PROCESS | 21612 | RSS: Main: 152748032 09:14:01 INFO - PROCESS | 21612 | 09:17:03 INFO - PROCESS | 21612 | Cycle 1(1): loaded http://localhost:52270/tests/dromaeo/cssquery-ext.html (next: http://localhost:52270/tests/dromaeo/cssquery-jquery.html) 09:17:04 INFO - PROCESS | 21612 | RSS: Main: 152154112 09:17:04 INFO - PROCESS | 21612 | 09:20:05 INFO - PROCESS | 21612 | Cycle 1(1): loaded http://localhost:52270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52270/tests/dromaeo/cssquery-mootools.html) 09:20:06 INFO - PROCESS | 21612 | RSS: Main: 151785472 09:20:06 INFO - PROCESS | 21612 | 09:23:07 INFO - PROCESS | 21612 | Cycle 1(1): loaded http://localhost:52270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52270/tests/dromaeo/cssquery-prototype.html) 09:23:08 INFO - PROCESS | 21612 | RSS: Main: 152670208 09:23:08 INFO - PROCESS | 21612 | 09:26:10 INFO - PROCESS | 21612 | Cycle 1(1): loaded http://localhost:52270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52270/tests/dromaeo/cssquery-yui.html) 09:26:11 INFO - PROCESS | 21612 | RSS: Main: 151117824 09:26:11 INFO - PROCESS | 21612 | 09:29:13 INFO - PROCESS | 21612 | Cycle 1(1): loaded http://localhost:52270/tests/dromaeo/cssquery-yui.html (next: http://localhost:52270/tests/dromaeo/cssquery-dojo.html) 09:29:13 INFO - PROCESS | 21612 | RSS: Main: 155582464 09:29:13 INFO - PROCESS | 21612 | 09:29:13 INFO - PROCESS | 21612 | __start_tp_report 09:29:13 INFO - PROCESS | 21612 | _x_x_mozilla_page_load 09:29:13 INFO - PROCESS | 21612 | _x_x_mozilla_page_load_details 09:29:13 INFO - PROCESS | 21612 | |i|pagename|runs| 09:29:13 INFO - PROCESS | 21612 | |0;dojo.html;3296.37368899909;3323.3021065576227;3356.412627790136;3369.1240277527836;3380.121168496192;5399.487048730374;5403.189521571766;5413.079776438005;5415.864603384913;5431.103867861798;5404.83785486435;5412.296401467814;5433.945660543393;5440.945590544094;5457.045017122007;4943.530364615356;4990.076835785373;5057.721825299607;5075.086484432801;5075.543201111899;4916.754162291889;4947.554720075193;5019.949800501985;5032.84901452957;5066.138756411419;5010.874728131807;5027.321311622921;5094.057599344114;5098.337216161913;5117.7185254810975;5066.771995260222;5094.337736094284;5097.337346144977;5114.846554603368;5133.178691409356;4843;4854.2233242681;4981.227909674007;5026.798928042874;5058.620603454719;5239.973800131013;5243.501867322599;5263.42102368743;5267.341582302212;5305.602079844027;5811.476967072984;5818.796342128006;5822.1266809978415;5823.155642431866;5823.621464604829;5835.854103647401;5841.85395365115;5848.181254624356;5960.731767070492;5971.940280597182;5508.834734957958;5553.8333849984565;5556.277683901108;5559.555235581144;5566.86082847928;5971.5222782177325;6010.909836352458;6033.064874944391;6040.09398590215;6049.727762250709;5618.803341883015;5699.145128230799;5731.799387021434;5793.594448388572;5798.1302804579655;5867.207926929896;5884.9705751470965;5887.470127688529;5888.146218798336;5900.1149827526215;5659.490645841894;5853.004989151855;5854.560907931922;5856.033754430471;5865.706714664335;5746.856328591819;5793.159991801165;5806.883862322815;5807.82576522705;5848.239728835224;4374.846880359172;4385.824567017284;4389.253826849444;4401.559844015637;4414.492333381638;3987.6809855211513;4015.759054456742;4035.3139966205817;4053.0880551875593;4063.3701776224734;5389.892202155935;5512.448755124536;5590.832275031756;5592.356878958972;5593.74828132735;5906.940930590639;5913.586048976616;5926.614770039933;5936.643801371932;5944.910826337608;5445.945540544623;5447.101228297287;5544.86137846549;5568.1091025435735;5595.496405323541;4887.755612219375;4908.067467181224;4908.631852611068;4915.139850526144;4922.606191504671;5896.233489646319;5951.107333899863;5953.434423729739;5997.7001149942325;6005.159277701126;5700.429957004267;5791.999999999915;5829.562782791392;5880.382559831156;5887.5289976802605;6020.54845886569;6027.547933904887;6063.5452341073715;6080.574359794772;6106.175666284995;5794.072948328248;5797.79707710245;5799.536037117105;5804.2744656917885;5837.124431335334;5743.9138412923;5791.276090488689;5855.209546711139;5870.911936321044;5923.881522369442;5693.914591281051;5716.42835716425;5734.254546908875;5739.71301434935;5747.511461525817;5626.549876009827;5717.342505611908;5718.742656580381;5723.370429252695;5738.971305143447;5527.917081243704;5605.663660180402;5608.46719561641;5626.099824028136;5653.971730141488;5702.7718891243885;5704.971475142598;5709.68596727184;5721.027425337619;5769.278840144982;5506.944930550803;5532.806351777668;5595.776168953359;5661.603687741983;5670.036093863971 09:29:13 INFO - PROCESS | 21612 | |1;ext.html;528.5771382893687;563.0034838336144;572.7680289482759;586.7330364684069;609.5489337889962;37691.811540942326;39017.60982390175;39110.80444597773;39243.21513569727;39312.41031384524;42271.15457690844;42527;42787.14425711492;42820.785896070556;42990.7850460748;8874.68938587148;9160.633574657006;9162.267018638526;9178.495182764946;9189.816203675922;9053;9188.770280742969;9196.816063678722;9203.861942070875;9219.032001639833;9286.396384235037;9311.72064838056;9315.161635452809;9326.114019168168;9360;9152.45085294881;9254.491002994799;9255.861162082574;9269.72190834276;9309.906900930971;9239.445633262027;9277.072292770736;9311.76720581984;9328.160465558132;9356.345055846094;44188.55811441877;44447.777761110985;44486.77756611196;44517;44556.77721611404;3704.6480584344713;3738.4953031340965;4039.7374170679104;4142.875713728593;4349.086691794695;29025.56461653077;29486.26284342887;29800;33853.830730846435;34710.13224669403;4206.852760153411;4226.556211597799;4251.087632069609;4326.199653064194;4369.453818272716;245144;247690;248299;248760;248947.0210595778;46794;63318;63666;64299.678501607195;64310;44404.555954440686;44526;44575.10849783051;44604.330935036;44775;16490;16627.25177366997;16667.083310418042;16743.83256167447;16776.161191940355;13310.800337994939;13423.530176443974;13449.058565900488;13513.864861351458;13514.459421623222;15675.216239188223;15693.21533923322;16228.107454089903;16289.51131466058;16383.508494745176;5942.7920022799;6108.602940808833;6137.324894261627;6239.875202496016;6253.437190652863;1041.8437234414746;1075.5160177919968;1147.1396452660504;1153.146671463128;1153.5904753812445;30548;30657;30697.846510767304;30862.537061944087;31252.531212031838;1145.4673576786834;1169.3393232823428;1171.812509998396;1211.5396149463147;1237.4369661803858;15723.528294151194;15956.441524546584;16212.189390530426;16265;16451.25969331383;356508;567008;568081;575520;843463;57822.7108864453;58433;58490;58504.4149558499;58524.122138167964;1510.4864346122372;1533.9923300383427;1535.7619568966604;1536.4622382166376;1544.289626771675;32189.517157243128;32732.509012364357;32871.17822054468;32902.50646240356;33593.49609755807;51619;52139.47860521346;52253;52296.21555676592;52386.73806630942;308953;309507;309521;310731;311040;36223.27553448969;36317.092072697335;36621;36847.63152368549;36927.44608830923;47405;47666.76166619144;48651.72238350416;49035.26447103225;49385.25922111243;40657.79671101626;40782.796086020564;42096.789516052224;42276;42607.78696106624;40769.79615101906;40949.795251023555;41501.169976600904;41640.375394369716;42125.789371052946;40136.59863401445;40137;40734.592654074266;40864.1827163461;41014.589854101076;34720.305593887475;34904;35136.82431587928;35283;35562.64437355697;27478;28084.578731319456;28231.858840705667;28373.43253134967;28390.148295551167 09:29:13 INFO - PROCESS | 21612 | |2;jquery.html;375.4593385524844;384.88838236911295;391.9784411857348;392.9705272104591;397.8945579421452;17328.913355433222;18608.720869186975;18908.527286817818;19094.71357929632;19155.61688766224;18565.257389704395;18735.883804162768;18977.715334269997;18977.90511047446;19000.61998760024;5636.549076073915;5818.767249310023;5840.328362238354;5857.589968702171;5867.794627188049;5329.946700532983;5552.5280351170195;5588.497035266825;5588.804391846286;5594.384617692051;5551.306086739158;5566.137248726433;5654;6317.115603815447;6325.33583973683;6244.3755624437645;6248.125262463259;6252.87494250117;6262.467690246334;6267.2165979252595;5527.281453411071;5551.028570000274;5588.273524441796;5611.859703507404;5661.348944871352;20675;20991.16035358599;21353.679694804592;22238.99924503401;22287.21994730193;2316.733575638806;2407.4703565215623;2507.8119141064312;2522.583773677341;3144.4654408750566;10625.884282150417;10645.78708425827;10678;11282;12760.872391276062;1883.2843519462654;1888.9622207555772;1915.1286164794985;1929.411529483507;1979.3369221310877;62495;65963;66592;67566.66216668935;67715.32284677139;11143.777124457465;11182.105431565455;11369.886301136883;11378.03286720638;11528.538858445569;15068.698626027419;15070.698586028218;15213.087214767149;15236.781057515373;15245.313960871787;7864.252895974873;8003.439759216799;8103.837923241502;8172.346212303001;8183.14077021916;7735.9613201933635;7815.983922090092;8248.340132789363;8304.501729896225;8436;4156.355764856452;4436.0462500562535;4551.271796512542;4685.273782563708;4898.559129678275;1860.7394964704952;1979.8416126709828;1981.3758666020158;2009.9095540700703;2030.319842852661;995.5569771451779;1001.6093723447862;1005.7234260578399;1019.90820826126;1081.648464249122;16711.331546737994;17704.734428983575;17739.556511087325;18094.547636308933;18288.54278643018;1022.99488502557;1068.2415485005577;1077.65515035188;1089.3953855610212;1107.341132026443;10100.595976161017;10725.946370268099;10749.677509674722;10778.029977301923;10818.567257309776;475684.86472702934;480682;483337;490560;494147;80523;83433;84412.57793710992;84428;84871;1010.5856598794459;1113.3932007056335;1116.1461481966303;1116.5031560955297;1120.882307357732;16403.42588009414;16439;16473.83526164723;16687.415940442028;16929.49211523607;33189.50215746814;33540.49689254614;34107.65892341045;35746.28507429889;36306;41962.79018604887;43039.784801075795;43480.13039739251;43588.78205608952;44284;8149.877751833846;8187.877181842397;8302.87545686803;8367.28878045373;8429.283510901641;12579.496820127093;13308.800367994294;13339.599812005656;13406.262655553648;13498.122622029538;5730.541556675373;7912.4856884302335;9710.320277580502;12068.939655302018;12182.451789669309;11949.10381721357;12127.575534856238;12141.878581214074;12418.316992565135;12422.316772577595;6705.6647167642395;6709.027191057172;12273.815892761795;12437.378131093228;12600.810987835373;8435.620397082268;8608.139186081342;8626.525541095049;8655.3508486865;8885.155910188521;8974.551272436222;10898;11141;11337.433128343715;11481.196316257781 09:29:13 INFO - PROCESS | 21612 | |3;mootools.html;1585.556044307594;1602.0788046873047;1854.1934258597512;1903.4194570655961;1957.3247229705755;7855.764327070183;8469.44948578342;8507.702230421937;8692.826143477134;8737.737867863967;8641.567921603926;8643.611037503311;8709.956450217756;8718.60766265518;8727.476351418904;2434.233216536785;2460.9753902460925;2462.741412151725;2469.086438017936;2471.295680730992;2426.599611064172;2503.6244563315468;2522.318973877052;2525.5201511712808;2527.128140791433;2406.9879650601724;2416.3838221253645;2506.862122583257;2513.42191296002;2515.182565666166;2493.5885578879643;2501.249625112459;2511.259178542316;2515.6855393075866;2524.1039431002005;2449.3386785567795;2471.2462698876834;2475;2475.851448913053;2538.1750930947333;8947.64209431622;8955.37312388133;8960.820783584357;8977.820443591092;8990.145936136056;5395.460453954613;5504.091824848895;5506.834794956158;5507.256520369779;5511.779528818843;3267.15054085937;3336.5495658086334;3376.5948086229564;3401.9659803402146;3439.7420193485586;947.4367293964945;1122.960696375623;1129.446571180124;1134.0927258193494;1142.520141540555;12661.873381266161;12693.809592856207;12700.745985080246;12703.555375561904;12705.555305564354;4750.786214620351;4804.519548045238;4835.298881662139;4839.927401088987;4997.375328083989;10716.624918127829;10752.086072683753;10774.4074075925;10777.299475534066;10808.945955270174;5446.21029950655;5489.3687225969525;5492.176173573996;5495.6153069284765;5532.695701736443;4777.235642297285;4867.756612169377;4920.778564964585;4946.183879659888;4983.50164983506;3843.865464708722;3867.149227170018;3896.6103389660807;3897.142628621699;3923.097687531884;1164.2665120973732;1168.5209064283604;1178.675864137369;1179.7994340962057;1193.0574845871665;1222.8165775133623;1250.662321173278;1259.9307038112809;1505.503183949294;1506.7589185730449;8307.875381869277;8428.704995325133;8445.282151017109;8463.026751923608;8483;546.1893821980124;552.9852720258291;554.9167624856303;562.5583916625511;573.1946615005924;6114.602550834271;6118.20463339763;6120.877582448326;6131.540134489931;6169.598976066542;10682.305650132872;11081.390523521122;11147;11180.888191117985;11231.71920701989;10750.623728169632;10812.67561973142;10888.40113793749;11028.50371733274;11097.83353249702;8384.329253659693;8460.111688272766;8484.36367272457;8494.830103397897;8534.53060081689;7986.680532778856;7992.800179995546;7998.880016799869;8094.10964793884;8162.020557533134;9311;9349.25205983506;9392.906070939476;9682.128608425275;9769.511524423608;9730.41617502952;9786.070323319273;10068.748281293027;10099.293049486465;10119.59521619127;7815.179406162271;7830.843383132419;7957.681692732226;8246.463979841292;8261.463004904663;8417.410781245255;8427.241548260687;8441.95779021101;8442.029166645914;8452.070272270168;7439.516431432156;7732.613369331623;7734.690612375442;7756.767296981099;7963.721269755531;7565.243475652391;7681;7724.961375193088;7852.13626501073;7860.3318717909615;7924.84150317002;7955.403344749051;7973.800654983672;7980.8802867955865;8029;6990.300969902969;7057.258987806412;7091.964540177266;7106.893396598952;7123.536970096927;7540.434467414856;7551.169371369255;7552.055993000875;7556.168821429528;7596.430267730053 09:29:13 INFO - PROCESS | 21612 | |4;prototype.html;362.51785125782703;367.94480827875816;370.0637387409854;370.5090754749957;380.4863434363611;6398.680065996699;6445.291017988017;6446.935530644692;6479.416852483276;6519.641419721914;6386.361363863612;6396.6481843498705;6399.648019358933;6400.039994000902;6400.583962042464;4732.90534189316;4842.975785121087;4893.730844803535;4907.2639104134305;4944.876378090549;4880.511948805127;4888.926666100011;4889.217725163974;4900.191468407708;4923.236898280755;4856.2958371036175;4862.829800956967;4864.586510146642;4864.878378040559;4879.243717223836;4854.927176092361;4855.101806165871;4869.464358920533;4885.828995985159;4891.9755401222765;4276.700630955835;4281.100968796556;4288.76411797351;4294.184105020067;4295.506016808075;5929.644221346733;6085.452309292141;6087.4521293083835;6088.391160883921;6090.512758979271;5689.943100568983;5704.714764261812;5705.6291341063115;5711.514521265697;5715.657060576379;6724.764633237862;6725.764598239038;6758.155230596176;6763.188417389895;6801.251862295144;4680.602148817355;4690.179218636725;4698.365720627706;4705.5764981151515;4715.834945776915;6990.231074581792;7028.718851245944;7058.576485410892;7066.364027237573;7087;4712.128256272532;4776.188048031843;4779.737114458738;4782.952170478251;4831.492693267156;4881.4630390657;4905.7301848397965;4911.877203069952;4916.311716359713;4921.089598424232;5655.434456554394;5658.264425624725;5663.433656634304;5672.432756724294;5673.035583950738;6757.358050985148;6788.049673045777;6789.898151527731;6794.184697836291;6818.4886133540185;1721.0964243771868;1741.0337262819003;1741.8606511479052;1741.947741567755;1743.2155530011546;1090.9781804363868;1135.4095870147478;1136.4601814138384;1137.766757814646;1144.0447226565911;6512.446442052384;6521.08704781331;6525.086487891699;6527.5757075789925;6529.053287273414;7042.542234754725;7054.400375967997;7059.6117213552725;7063.081799366049;7072.611006394594;6316.115743795872;6373.840653983595;6510.44661203803;6581.2760596334365;6598.637074960923;3840.7503512272174;3846.076941534012;3852.9036774080873;3859.517560304962;3871.709621778378;7323.560586364835;7325.597092159983;7326.084239470067;7352.669129889167;7370.8894366584545;7197.064381630459;7255.201927787939;7266.45501587383;7273.418126549864;7274.56352618834;7174.784756457315;7299;7361.705531778776;7368.189499155089;7377.188509263977;7080;7110;7110.537815042006;7116.964415177891;7131.037309963089;6967.7212911482975;6968.128983877015;6970.23327433992;6973.65131743421;6982.476314276348;7304.707811687473;7307.488475806643;7347.044884165024;7349.412047036118;7350.852982940418;4759.476457589732;4844.75776211181;4884.82903098404;4886.560209581013;4901.215805471107;7016.719331226694;7054.717811287491;7086.291370862872;7087;7089.184743754328;6849.794506164823;6867.3476019778045;6871.175458944958;6871.209810871814;6878.071460352789;6856.794296171123;6864.24493305746;6875.4155896749335;6878.105846239957;6882.965585172042;6581.835454113685;6729.158855143107;6781.660916954232;6788.66056697173;6791.219009813737;6905.136857892763;6914.965425172842;6929.826754331182;6949.061876646588;6953.75661851853;6768.9661551691925;6771;6773.89839152423;6783.830404239933;6824.249332573314 09:29:13 INFO - PROCESS | 21612 | |5;yui.html;775.6083177995114;790.229526211943;863.443079213907;912.2610685344871;913.9954300228497;14721.484748033821;14900.925495372509;14907.254637268134;14921.626959326022;14938.551843444688;14172.716545669105;14285.357158927847;14285.642858928506;14387.1367717937;14416.558344165578;782.8395178988308;905.6467977488785;922.9723108306762;929.3866048408051;932.953352332384;939.7791518993065;942.4533770413178;942.7501712046313;945.078548415293;948.7485816258662;1001.1790331927822;1003.4882210072842;1005.1054561440324;1010.4695035106591;1011.0193112680688;981.7251169672503;983.2822039910869;987.1757082835769;987.2595553334999;987.5309228116658;734.7832389445126;736.3740820302753;737.7823542055106;738.4129616954534;738.8226825561826;13378.598642040753;13455.529056482976;13465.124766890121;13560.45758169672;13639.659008524766;13956.651083722887;14116.858831411657;14218.715625687428;14272.928635356757;14331.641708957255;11668.241564298378;11717.23837950539;11795.29228246308;11832.940835295769;11972.521099156023;3942.448057271984;3976.1252524444576;3978.8209530570903;3983.98008009961;4001.0397504598977;48512.51487485115;49129.50870491285;49398.50601493975;49433.25850112251;52634;9827.55775990068;10047.196224302039;10047.447390393452;10183.745406364753;11130.721731956766;17645.117744112744;17739.11304434773;17743.467695969142;17845.37541186052;17861;8052.436329456999;8191.918080819235;8274.627641756015;8282.917170828336;8298.543580103153;4587.61005314552;4705.458872229738;4727.2436410174205;4809.639277054235;4911.8280860169725;3425.554677891908;3460.602030766444;3466.30673865228;3509.842057107436;3537.4163263061305;654.564714464885;660.3462572053728;662.8011596521025;663.3167837127767;670.8859493886051;622.4149299658307;624.8031869961038;651.9698875776262;662.8641128568631;764.2090436398302;9057.864132038025;9267.304952128618;9350.812983740287;9355.719328420158;9428.340016198801;580.3297191743543;668.7224801707237;713.932176443237;728.4572993120054;758.4577027425418;4051.7974101294817;4146.792660366969;4175.645070169009;4221.915561688749;4339.7613131278085;60108.699456502436;60883.39116608866;61121.38878611246;61239.69380153071;61405;51580;51749.741251293504;51767.7411612947;52474.47525524772;55896.720516397974;46461.76769116133;46538;47440;47582.762086189345;48029.51970480251;8309.95845020771;8395.580220989048;8499.83000340002;8546.78633034179;8555.401121921655;35004.82497587496;35837.462438062925;36606.267874641824;36626.26747465089;37161;41811;42299.7885010573;47210.76394618005;47486;48535;11329.093672506344;11348;11536.769264614493;11592.072634189077;11625.18623696367;10941.343519388862;11411.315321080761;12057.51769929228;12476.313802740937;12713.046521511109;11241.100711943189;11510.136739744385;11556.537738490366;11849.585264515701;12024.519019239133;11844.940775296069;11846.822297665369;12053.035757139232;12096.637100886988;12148;10900.454977250947;10935.56257749681;10939.343639381663;11004.834927476255;11331.206815522833;9523.619055237712;9653.613855445985;9681.70954871355;9814.06766357195;9882.950585247028;9615.471149086867;9870.210383169473;9949.403035817873;9960.701178964642;9995.150412215044 09:29:13 INFO - PROCESS | 21612 | __end_tp_report 09:29:13 INFO - PROCESS | 21612 | __start_cc_report 09:29:13 INFO - PROCESS | 21612 | _x_x_mozilla_cycle_collect,320 09:29:13 INFO - PROCESS | 21612 | __end_cc_report 09:29:13 INFO - PROCESS | 21612 | __startTimestamp1462552153448__endTimestamp 09:29:13 INFO - PROCESS | 21612 | 09:29:13 INFO - PROCESS | 21612 | ------- Summary: start ------- 09:29:13 INFO - PROCESS | 21612 | Number of tests: 6 09:29:13 INFO - PROCESS | 21612 | 09:29:13 INFO - PROCESS | 21612 | [#0] dojo.html Cycles:165 Average:5432.16 Median:5626.10 stddev:594.17 (10.6%) stddev-sans-first:571.88 09:29:13 INFO - PROCESS | 21612 | Values: 3296.4 3323.3 3356.4 3369.1 3380.1 5399.5 5403.2 5413.1 5415.9 5431.1 5404.8 5412.3 5433.9 5440.9 5457.0 4943.5 4990.1 5057.7 5075.1 5075.5 4916.8 4947.6 5019.9 5032.8 5066.1 5010.9 5027.3 5094.1 5098.3 5117.7 5066.8 5094.3 5097.3 5114.8 5133.2 4843.0 4854.2 4981.2 5026.8 5058.6 5240.0 5243.5 5263.4 5267.3 5305.6 5811.5 5818.8 5822.1 5823.2 5823.6 5835.9 5841.9 5848.2 5960.7 5971.9 5508.8 5553.8 5556.3 5559.6 5566.9 5971.5 6010.9 6033.1 6040.1 6049.7 5618.8 5699.1 5731.8 5793.6 5798.1 5867.2 5885.0 5887.5 5888.1 5900.1 5659.5 5853.0 5854.6 5856.0 5865.7 5746.9 5793.2 5806.9 5807.8 5848.2 4374.8 4385.8 4389.3 4401.6 4414.5 3987.7 4015.8 4035.3 4053.1 4063.4 5389.9 5512.4 5590.8 5592.4 5593.7 5906.9 5913.6 5926.6 5936.6 5944.9 5445.9 5447.1 5544.9 5568.1 5595.5 4887.8 4908.1 4908.6 4915.1 4922.6 5896.2 5951.1 5953.4 5997.7 6005.2 5700.4 5792.0 5829.6 5880.4 5887.5 6020.5 6027.5 6063.5 6080.6 6106.2 5794.1 5797.8 5799.5 5804.3 5837.1 5743.9 5791.3 5855.2 5870.9 5923.9 5693.9 5716.4 5734.3 5739.7 5747.5 5626.5 5717.3 5718.7 5723.4 5739.0 5527.9 5605.7 5608.5 5626.1 5654.0 5702.8 5705.0 5709.7 5721.0 5769.3 5506.9 5532.8 5595.8 5661.6 5670.0 09:29:13 INFO - PROCESS | 21612 | 09:29:13 INFO - PROCESS | 21612 | [#1] ext.html Cycles:180 Average:54876.93 Median:40906.99 stddev:111399.20 (272.3%) stddev-sans-first:111636.97 09:29:13 INFO - PROCESS | 21612 | Values: 528.6 563.0 572.8 586.7 609.5 37691.8 39017.6 39110.8 39243.2 39312.4 42271.2 42527.0 42787.1 42820.8 42990.8 8874.7 9160.6 9162.3 9178.5 9189.8 9053.0 9188.8 9196.8 9203.9 9219.0 9286.4 9311.7 9315.2 9326.1 9360.0 9152.5 9254.5 9255.9 9269.7 9309.9 9239.4 9277.1 9311.8 9328.2 9356.3 44188.6 44447.8 44486.8 44517.0 44556.8 3704.6 3738.5 4039.7 4142.9 4349.1 29025.6 29486.3 29800.0 33853.8 34710.1 4206.9 4226.6 4251.1 4326.2 4369.5 245144.0 247690.0 248299.0 248760.0 248947.0 46794.0 63318.0 63666.0 64299.7 64310.0 44404.6 44526.0 44575.1 44604.3 44775.0 16490.0 16627.3 16667.1 16743.8 16776.2 13310.8 13423.5 13449.1 13513.9 13514.5 15675.2 15693.2 16228.1 16289.5 16383.5 5942.8 6108.6 6137.3 6239.9 6253.4 1041.8 1075.5 1147.1 1153.1 1153.6 30548.0 30657.0 30697.8 30862.5 31252.5 1145.5 1169.3 1171.8 1211.5 1237.4 15723.5 15956.4 16212.2 16265.0 16451.3 356508.0 567008.0 568081.0 575520.0 843463.0 57822.7 58433.0 58490.0 58504.4 58524.1 1510.5 1534.0 1535.8 1536.5 1544.3 32189.5 32732.5 32871.2 32902.5 33593.5 51619.0 52139.5 52253.0 52296.2 52386.7 308953.0 309507.0 309521.0 310731.0 311040.0 36223.3 36317.1 36621.0 36847.6 36927.4 47405.0 47666.8 48651.7 49035.3 49385.3 40657.8 40782.8 42096.8 42276.0 42607.8 40769.8 40949.8 41501.2 41640.4 42125.8 40136.6 40137.0 40734.6 40864.2 41014.6 34720.3 34904.0 35136.8 35283.0 35562.6 27478.0 28084.6 28231.9 28373.4 28390.1 09:29:13 INFO - PROCESS | 21612 | 09:29:13 INFO - PROCESS | 21612 | [#2] jquery.html Cycles:180 Average:27404.34 Median:2515.20 stddev:79457.14 (3159.1%) stddev-sans-first:79654.12 09:29:13 INFO - PROCESS | 21612 | Values: 375.5 384.9 392.0 393.0 397.9 17328.9 18608.7 18908.5 19094.7 19155.6 18565.3 18735.9 18977.7 18977.9 19000.6 5636.5 5818.8 5840.3 5857.6 5867.8 5329.9 5552.5 5588.5 5588.8 5594.4 5551.3 5566.1 5654.0 6317.1 6325.3 6244.4 6248.1 6252.9 6262.5 6267.2 5527.3 5551.0 5588.3 5611.9 5661.3 20675.0 20991.2 21353.7 22239.0 22287.2 2316.7 2407.5 2507.8 2522.6 3144.5 10625.9 10645.8 10678.0 11282.0 12760.9 1883.3 1889.0 1915.1 1929.4 1979.3 62495.0 65963.0 66592.0 67566.7 67715.3 11143.8 11182.1 11369.9 11378.0 11528.5 15068.7 15070.7 15213.1 15236.8 15245.3 7864.3 8003.4 8103.8 8172.3 8183.1 7736.0 7816.0 8248.3 8304.5 8436.0 4156.4 4436.0 4551.3 4685.3 4898.6 1860.7 1979.8 1981.4 2009.9 2030.3 995.6 1001.6 1005.7 1019.9 1081.6 16711.3 17704.7 17739.6 18094.5 18288.5 1023.0 1068.2 1077.7 1089.4 1107.3 10100.6 10725.9 10749.7 10778.0 10818.6 475684.9 480682.0 483337.0 490560.0 494147.0 80523.0 83433.0 84412.6 84428.0 84871.0 1010.6 1113.4 1116.1 1116.5 1120.9 16403.4 16439.0 16473.8 16687.4 16929.5 33189.5 33540.5 34107.7 35746.3 36306.0 41962.8 43039.8 43480.1 43588.8 44284.0 8149.9 8187.9 8302.9 8367.3 8429.3 12579.5 13308.8 13339.6 13406.3 13498.1 5730.5 7912.5 9710.3 12068.9 12182.5 11949.1 12127.6 12141.9 12418.3 12422.3 6705.7 6709.0 12273.8 12437.4 12600.8 8435.6 8608.1 8626.5 8655.4 8885.2 8974.6 10898.0 11141.0 11337.4 11481.2 09:29:13 INFO - PROCESS | 21612 | 09:29:13 INFO - PROCESS | 21612 | [#3] mootools.html Cycles:180 Average:6193.46 Median:5490.77 stddev:3337.14 (60.8%) stddev-sans-first:3328.53 09:29:13 INFO - PROCESS | 21612 | Values: 1585.6 1602.1 1854.2 1903.4 1957.3 7855.8 8469.4 8507.7 8692.8 8737.7 8641.6 8643.6 8710.0 8718.6 8727.5 2434.2 2461.0 2462.7 2469.1 2471.3 2426.6 2503.6 2522.3 2525.5 2527.1 2407.0 2416.4 2506.9 2513.4 2515.2 2493.6 2501.2 2511.3 2515.7 2524.1 2449.3 2471.2 2475.0 2475.9 2538.2 8947.6 8955.4 8960.8 8977.8 8990.1 5395.5 5504.1 5506.8 5507.3 5511.8 3267.2 3336.5 3376.6 3402.0 3439.7 947.4 1123.0 1129.4 1134.1 1142.5 12661.9 12693.8 12700.7 12703.6 12705.6 4750.8 4804.5 4835.3 4839.9 4997.4 10716.6 10752.1 10774.4 10777.3 10808.9 5446.2 5489.4 5492.2 5495.6 5532.7 4777.2 4867.8 4920.8 4946.2 4983.5 3843.9 3867.1 3896.6 3897.1 3923.1 1164.3 1168.5 1178.7 1179.8 1193.1 1222.8 1250.7 1259.9 1505.5 1506.8 8307.9 8428.7 8445.3 8463.0 8483.0 546.2 553.0 554.9 562.6 573.2 6114.6 6118.2 6120.9 6131.5 6169.6 10682.3 11081.4 11147.0 11180.9 11231.7 10750.6 10812.7 10888.4 11028.5 11097.8 8384.3 8460.1 8484.4 8494.8 8534.5 7986.7 7992.8 7998.9 8094.1 8162.0 9311.0 9349.3 9392.9 9682.1 9769.5 9730.4 9786.1 10068.7 10099.3 10119.6 7815.2 7830.8 7957.7 8246.5 8261.5 8417.4 8427.2 8442.0 8442.0 8452.1 7439.5 7732.6 7734.7 7756.8 7963.7 7565.2 7681.0 7725.0 7852.1 7860.3 7924.8 7955.4 7973.8 7980.9 8029.0 6990.3 7057.3 7092.0 7106.9 7123.5 7540.4 7551.2 7552.1 7556.2 7596.4 09:29:13 INFO - PROCESS | 21612 | 09:29:13 INFO - PROCESS | 21612 | [#4] prototype.html Cycles:180 Average:5711.70 Median:6494.93 stddev:1729.97 (26.6%) stddev-sans-first:1687.59 09:29:13 INFO - PROCESS | 21612 | Values: 362.5 367.9 370.1 370.5 380.5 6398.7 6445.3 6446.9 6479.4 6519.6 6386.4 6396.6 6399.6 6400.0 6400.6 4732.9 4843.0 4893.7 4907.3 4944.9 4880.5 4888.9 4889.2 4900.2 4923.2 4856.3 4862.8 4864.6 4864.9 4879.2 4854.9 4855.1 4869.5 4885.8 4892.0 4276.7 4281.1 4288.8 4294.2 4295.5 5929.6 6085.5 6087.5 6088.4 6090.5 5689.9 5704.7 5705.6 5711.5 5715.7 6724.8 6725.8 6758.2 6763.2 6801.3 4680.6 4690.2 4698.4 4705.6 4715.8 6990.2 7028.7 7058.6 7066.4 7087.0 4712.1 4776.2 4779.7 4783.0 4831.5 4881.5 4905.7 4911.9 4916.3 4921.1 5655.4 5658.3 5663.4 5672.4 5673.0 6757.4 6788.0 6789.9 6794.2 6818.5 1721.1 1741.0 1741.9 1741.9 1743.2 1091.0 1135.4 1136.5 1137.8 1144.0 6512.4 6521.1 6525.1 6527.6 6529.1 7042.5 7054.4 7059.6 7063.1 7072.6 6316.1 6373.8 6510.4 6581.3 6598.6 3840.8 3846.1 3852.9 3859.5 3871.7 7323.6 7325.6 7326.1 7352.7 7370.9 7197.1 7255.2 7266.5 7273.4 7274.6 7174.8 7299.0 7361.7 7368.2 7377.2 7080.0 7110.0 7110.5 7117.0 7131.0 6967.7 6968.1 6970.2 6973.7 6982.5 7304.7 7307.5 7347.0 7349.4 7350.9 4759.5 4844.8 4884.8 4886.6 4901.2 7016.7 7054.7 7086.3 7087.0 7089.2 6849.8 6867.3 6871.2 6871.2 6878.1 6856.8 6864.2 6875.4 6878.1 6883.0 6581.8 6729.2 6781.7 6788.7 6791.2 6905.1 6915.0 6929.8 6949.1 6953.8 6769.0 6771.0 6773.9 6783.8 6824.2 09:29:13 INFO - PROCESS | 21612 | 09:29:13 INFO - PROCESS | 21612 | [#5] yui.html Cycles:180 Average:14347.91 Median:25969.00 stddev:16480.53 (63.5%) stddev-sans-first:16495.24 09:29:13 INFO - PROCESS | 21612 | Values: 775.6 790.2 863.4 912.3 914.0 14721.5 14900.9 14907.3 14921.6 14938.6 14172.7 14285.4 14285.6 14387.1 14416.6 782.8 905.6 923.0 929.4 933.0 939.8 942.5 942.8 945.1 948.7 1001.2 1003.5 1005.1 1010.5 1011.0 981.7 983.3 987.2 987.3 987.5 734.8 736.4 737.8 738.4 738.8 13378.6 13455.5 13465.1 13560.5 13639.7 13956.7 14116.9 14218.7 14272.9 14331.6 11668.2 11717.2 11795.3 11832.9 11972.5 3942.4 3976.1 3978.8 3984.0 4001.0 48512.5 49129.5 49398.5 49433.3 52634.0 9827.6 10047.2 10047.4 10183.7 11130.7 17645.1 17739.1 17743.5 17845.4 17861.0 8052.4 8191.9 8274.6 8282.9 8298.5 4587.6 4705.5 4727.2 4809.6 4911.8 3425.6 3460.6 3466.3 3509.8 3537.4 654.6 660.3 662.8 663.3 670.9 622.4 624.8 652.0 662.9 764.2 9057.9 9267.3 9350.8 9355.7 9428.3 580.3 668.7 713.9 728.5 758.5 4051.8 4146.8 4175.6 4221.9 4339.8 60108.7 60883.4 61121.4 61239.7 61405.0 51580.0 51749.7 51767.7 52474.5 55896.7 46461.8 46538.0 47440.0 47582.8 48029.5 8310.0 8395.6 8499.8 8546.8 8555.4 35004.8 35837.5 36606.3 36626.3 37161.0 41811.0 42299.8 47210.8 47486.0 48535.0 11329.1 11348.0 11536.8 11592.1 11625.2 10941.3 11411.3 12057.5 12476.3 12713.0 11241.1 11510.1 11556.5 11849.6 12024.5 11844.9 11846.8 12053.0 12096.6 12148.0 10900.5 10935.6 10939.3 11004.8 11331.2 9523.6 9653.6 9681.7 9814.1 9883.0 9615.5 9870.2 9949.4 9960.7 9995.2 09:29:13 INFO - PROCESS | 21612 | -------- Summary: end -------- 09:29:13 INFO - PROCESS | 21612 | 09:29:14 INFO - TEST-INFO | 21612: exit 0 09:29:14 INFO - TEST-OK | dromaeo_css | took 1108271ms 09:29:14 INFO - TEST-START | kraken 09:29:14 INFO - operating with platform_type : linux_ 09:29:14 INFO - Initialising browser for kraken test... 09:29:14 INFO - TEST-INFO | started process 21855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV0XDPZ/profile http://localhost:52270/getInfo.html) 09:29:17 INFO - PROCESS | 21855 | 09:29:17 INFO - PROCESS | 21855 | (process:21933): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:29:18 INFO - PROCESS | 21855 | __metrics Screen width/height:1600/1200 09:29:18 INFO - PROCESS | 21855 | colorDepth:24 09:29:18 INFO - PROCESS | 21855 | Browser inner width/height: 1024/697 09:29:18 INFO - PROCESS | 21855 | __metrics 09:29:19 ERROR - PROCESS | 21855 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:29:20 INFO - TEST-INFO | 21855: exit 0 09:29:20 INFO - Browser initialized. 09:29:20 INFO - Running cycle 1/1 for kraken test... 09:29:20 INFO - TEST-INFO | started process 21983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV0XDPZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:29:21 INFO - PROCESS | 21983 | 09:29:21 INFO - PROCESS | 21983 | (process:22049): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:29:31 INFO - PROCESS | 21983 | RSS: Main: 149757952 09:29:31 INFO - PROCESS | 21983 | 09:29:34 INFO - PROCESS | 21983 | Cycle 1(1): loaded http://localhost:52270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52270/tests/kraken/driver.html?testName=audio-beat-detection) 09:29:35 INFO - PROCESS | 21983 | RSS: Main: 154267648 09:29:35 INFO - PROCESS | 21983 | 09:29:37 INFO - PROCESS | 21983 | Cycle 1(1): loaded http://localhost:52270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52270/tests/kraken/driver.html?testName=audio-dft) 09:29:38 INFO - PROCESS | 21983 | RSS: Main: 154214400 09:29:38 INFO - PROCESS | 21983 | 09:29:41 INFO - PROCESS | 21983 | Cycle 1(1): loaded http://localhost:52270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52270/tests/kraken/driver.html?testName=audio-fft) 09:29:41 INFO - PROCESS | 21983 | RSS: Main: 154587136 09:29:41 INFO - PROCESS | 21983 | 09:29:43 INFO - PROCESS | 21983 | Cycle 1(1): loaded http://localhost:52270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52270/tests/kraken/driver.html?testName=audio-oscillator) 09:29:44 INFO - PROCESS | 21983 | RSS: Main: 154378240 09:29:44 INFO - PROCESS | 21983 | 09:29:46 INFO - PROCESS | 21983 | Cycle 1(1): loaded http://localhost:52270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:29:47 INFO - PROCESS | 21983 | RSS: Main: 154472448 09:29:47 INFO - PROCESS | 21983 | 09:29:50 INFO - PROCESS | 21983 | Cycle 1(1): loaded http://localhost:52270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52270/tests/kraken/driver.html?testName=imaging-darkroom) 09:29:51 INFO - PROCESS | 21983 | RSS: Main: 154583040 09:29:51 INFO - PROCESS | 21983 | 09:29:54 INFO - PROCESS | 21983 | Cycle 1(1): loaded http://localhost:52270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52270/tests/kraken/driver.html?testName=imaging-desaturate) 09:29:55 INFO - PROCESS | 21983 | RSS: Main: 154812416 09:29:55 INFO - PROCESS | 21983 | 09:29:57 INFO - PROCESS | 21983 | Cycle 1(1): loaded http://localhost:52270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52270/tests/kraken/driver.html?testName=json-parse-financial) 09:29:58 INFO - PROCESS | 21983 | RSS: Main: 155234304 09:29:58 INFO - PROCESS | 21983 | 09:29:59 INFO - PROCESS | 21983 | Cycle 1(1): loaded http://localhost:52270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:30:00 INFO - PROCESS | 21983 | RSS: Main: 155054080 09:30:00 INFO - PROCESS | 21983 | 09:30:02 INFO - PROCESS | 21983 | Cycle 1(1): loaded http://localhost:52270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52270/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:30:03 INFO - PROCESS | 21983 | RSS: Main: 154767360 09:30:03 INFO - PROCESS | 21983 | 09:30:05 INFO - PROCESS | 21983 | Cycle 1(1): loaded http://localhost:52270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:30:05 INFO - PROCESS | 21983 | RSS: Main: 155086848 09:30:05 INFO - PROCESS | 21983 | 09:30:08 INFO - PROCESS | 21983 | Cycle 1(1): loaded http://localhost:52270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:30:08 INFO - PROCESS | 21983 | RSS: Main: 155357184 09:30:08 INFO - PROCESS | 21983 | 09:30:11 INFO - PROCESS | 21983 | Cycle 1(1): loaded http://localhost:52270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:30:11 INFO - PROCESS | 21983 | RSS: Main: 155332608 09:30:11 INFO - PROCESS | 21983 | 09:30:13 INFO - PROCESS | 21983 | Cycle 1(1): loaded http://localhost:52270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52270/tests/kraken/driver.html?testName=ai-astar) 09:30:13 INFO - PROCESS | 21983 | RSS: Main: 156590080 09:30:13 INFO - PROCESS | 21983 | 09:30:13 INFO - PROCESS | 21983 | __start_tp_report 09:30:13 INFO - PROCESS | 21983 | _x_x_mozilla_page_load 09:30:13 INFO - PROCESS | 21983 | _x_x_mozilla_page_load_details 09:30:13 INFO - PROCESS | 21983 | |i|pagename|runs| 09:30:13 INFO - PROCESS | 21983 | |0;ai-astar;110;107;111;113;112;124;113;112;112;112 09:30:13 INFO - PROCESS | 21983 | |1;audio-beat-detection;161;134;155;174;128;155;163;130;176;128 09:30:13 INFO - PROCESS | 21983 | |2;audio-dft;161;161;163;164;161;161;162;163;165;161 09:30:13 INFO - PROCESS | 21983 | |3;audio-fft;76;78;76;166;75;76;75;73;170;73 09:30:13 INFO - PROCESS | 21983 | |4;audio-oscillator;93;93;149;94;93;94;149;93;94;143 09:30:13 INFO - PROCESS | 21983 | |5;imaging-gaussian-blur;117;118;117;118;117;117;117;117;117;117 09:30:13 INFO - PROCESS | 21983 | |6;imaging-darkroom;146;146;146;146;147;146;146;146;148;146 09:30:13 INFO - PROCESS | 21983 | |7;imaging-desaturate;98;96;96;95;96;96;96;96;96;96 09:30:13 INFO - PROCESS | 21983 | |8;json-parse-financial;55;58;58;56;56;57;56;60;56;55 09:30:13 INFO - PROCESS | 21983 | |9;json-stringify-tinderbox;83;83;82;82;82;82;83;83;85;84 09:30:13 INFO - PROCESS | 21983 | |10;stanford-crypto-aes;77;78;88;79;79;79;82;85;80;80 09:30:13 INFO - PROCESS | 21983 | |11;stanford-crypto-ccm;115;115;114;118;116;119;120;123;116;114 09:30:13 INFO - PROCESS | 21983 | |12;stanford-crypto-pbkdf2;147;139;146;146;145;145;144;149;139;142 09:30:13 INFO - PROCESS | 21983 | |13;stanford-crypto-sha256-iterative;68;65;66;66;66;68;66;68;66;67 09:30:13 INFO - PROCESS | 21983 | __end_tp_report 09:30:13 INFO - PROCESS | 21983 | __start_cc_report 09:30:13 INFO - PROCESS | 21983 | _x_x_mozilla_cycle_collect,851 09:30:13 INFO - PROCESS | 21983 | __end_cc_report 09:30:13 INFO - PROCESS | 21983 | __startTimestamp1462552213850__endTimestamp 09:30:13 INFO - PROCESS | 21983 | 09:30:13 INFO - PROCESS | 21983 | ------- Summary: start ------- 09:30:13 INFO - PROCESS | 21983 | Number of tests: 14 09:30:13 INFO - PROCESS | 21983 | 09:30:13 INFO - PROCESS | 21983 | [#0] ai-astar Cycles:10 Average:112.60 Median:112.00 stddev:4.38 (3.9%) stddev-sans-first:4.54 09:30:13 INFO - PROCESS | 21983 | Values: 110.0 107.0 111.0 113.0 112.0 124.0 113.0 112.0 112.0 112.0 09:30:13 INFO - PROCESS | 21983 | 09:30:13 INFO - PROCESS | 21983 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:158.00 stddev:18.90 (12.0%) stddev-sans-first:19.65 09:30:13 INFO - PROCESS | 21983 | Values: 161.0 134.0 155.0 174.0 128.0 155.0 163.0 130.0 176.0 128.0 09:30:13 INFO - PROCESS | 21983 | 09:30:13 INFO - PROCESS | 21983 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.48 (0.9%) stddev-sans-first:1.50 09:30:13 INFO - PROCESS | 21983 | Values: 161.0 161.0 163.0 164.0 161.0 161.0 162.0 163.0 165.0 161.0 09:30:13 INFO - PROCESS | 21983 | 09:30:13 INFO - PROCESS | 21983 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.50 stddev:39.15 (51.8%) stddev-sans-first:40.99 09:30:13 INFO - PROCESS | 21983 | Values: 76.0 78.0 76.0 166.0 75.0 76.0 75.0 73.0 170.0 73.0 09:30:13 INFO - PROCESS | 21983 | 09:30:13 INFO - PROCESS | 21983 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:93.00 stddev:25.93 (27.9%) stddev-sans-first:26.81 09:30:13 INFO - PROCESS | 21983 | Values: 93.0 93.0 149.0 94.0 93.0 94.0 149.0 93.0 94.0 143.0 09:30:13 INFO - PROCESS | 21983 | 09:30:13 INFO - PROCESS | 21983 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:30:13 INFO - PROCESS | 21983 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 09:30:13 INFO - PROCESS | 21983 | 09:30:13 INFO - PROCESS | 21983 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 09:30:13 INFO - PROCESS | 21983 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 148.0 146.0 09:30:13 INFO - PROCESS | 21983 | 09:30:13 INFO - PROCESS | 21983 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.33 09:30:13 INFO - PROCESS | 21983 | Values: 98.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 09:30:13 INFO - PROCESS | 21983 | 09:30:13 INFO - PROCESS | 21983 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.50 stddev:1.57 (2.8%) stddev-sans-first:1.54 09:30:13 INFO - PROCESS | 21983 | Values: 55.0 58.0 58.0 56.0 56.0 57.0 56.0 60.0 56.0 55.0 09:30:13 INFO - PROCESS | 21983 | 09:30:13 INFO - PROCESS | 21983 | [#9] json-stringify-tinderbox Cycles:10 Average:82.90 Median:83.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 09:30:13 INFO - PROCESS | 21983 | Values: 83.0 83.0 82.0 82.0 82.0 82.0 83.0 83.0 85.0 84.0 09:30:13 INFO - PROCESS | 21983 | 09:30:13 INFO - PROCESS | 21983 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:3.40 (4.3%) stddev-sans-first:3.33 09:30:13 INFO - PROCESS | 21983 | Values: 77.0 78.0 88.0 79.0 79.0 79.0 82.0 85.0 80.0 80.0 09:30:13 INFO - PROCESS | 21983 | 09:30:13 INFO - PROCESS | 21983 | [#11] stanford-crypto-ccm Cycles:10 Average:117.00 Median:117.00 stddev:2.94 (2.5%) stddev-sans-first:3.03 09:30:13 INFO - PROCESS | 21983 | Values: 115.0 115.0 114.0 118.0 116.0 119.0 120.0 123.0 116.0 114.0 09:30:13 INFO - PROCESS | 21983 | 09:30:13 INFO - PROCESS | 21983 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.20 Median:145.50 stddev:3.29 (2.3%) stddev-sans-first:3.33 09:30:13 INFO - PROCESS | 21983 | Values: 147.0 139.0 146.0 146.0 145.0 145.0 144.0 149.0 139.0 142.0 09:30:13 INFO - PROCESS | 21983 | 09:30:13 INFO - PROCESS | 21983 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:1.07 (1.6%) stddev-sans-first:1.01 09:30:13 INFO - PROCESS | 21983 | Values: 68.0 65.0 66.0 66.0 66.0 68.0 66.0 68.0 66.0 67.0 09:30:13 INFO - PROCESS | 21983 | -------- Summary: end -------- 09:30:13 INFO - PROCESS | 21983 | 09:30:14 INFO - TEST-INFO | 21983: exit 0 09:30:14 INFO - TEST-OK | kraken | took 60681ms 09:30:14 INFO - SUITE-END | took 1168s 09:30:15 INFO - Completed test suite (00:19:29) 09:30:15 INFO - javascript benchmark 09:30:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3296.37368899909, 3323.3021065576227, 3356.412627790136, 3369.1240277527836, 3380.121168496192, 5399.487048730374, 5403.189521571766, 5413.079776438005, 5415.864603384913, 5431.103867861798, 5404.83785486435, 5412.296401467814, 5433.945660543393, 5440.945590544094, 5457.045017122007, 4943.530364615356, 4990.076835785373, 5057.721825299607, 5075.086484432801, 5075.543201111899, 4916.754162291889, 4947.554720075193, 5019.949800501985, 5032.84901452957, 5066.138756411419, 5010.874728131807, 5027.321311622921, 5094.057599344114, 5098.337216161913, 5117.7185254810975, 5066.771995260222, 5094.337736094284, 5097.337346144977, 5114.846554603368, 5133.178691409356, 4843.0, 4854.2233242681, 4981.227909674007, 5026.798928042874, 5058.620603454719, 5239.973800131013, 5243.501867322599, 5263.42102368743, 5267.341582302212, 5305.602079844027, 5811.476967072984, 5818.796342128006, 5822.1266809978415, 5823.155642431866, 5823.621464604829, 5835.854103647401, 5841.85395365115, 5848.181254624356, 5960.731767070492, 5971.940280597182, 5508.834734957958, 5553.8333849984565, 5556.277683901108, 5559.555235581144, 5566.86082847928, 5971.5222782177325, 6010.909836352458, 6033.064874944391, 6040.09398590215, 6049.727762250709, 5618.803341883015, 5699.145128230799, 5731.799387021434, 5793.594448388572, 5798.1302804579655, 5867.207926929896, 5884.9705751470965, 5887.470127688529, 5888.146218798336, 5900.1149827526215, 5659.490645841894, 5853.004989151855, 5854.560907931922, 5856.033754430471, 5865.706714664335, 5746.856328591819, 5793.159991801165, 5806.883862322815, 5807.82576522705, 5848.239728835224, 4374.846880359172, 4385.824567017284, 4389.253826849444, 4401.559844015637, 4414.492333381638, 3987.6809855211513, 4015.759054456742, 4035.3139966205817, 4053.0880551875593, 4063.3701776224734, 5389.892202155935, 5512.448755124536, 5590.832275031756, 5592.356878958972, 5593.74828132735, 5906.940930590639, 5913.586048976616, 5926.614770039933, 5936.643801371932, 5944.910826337608, 5445.945540544623, 5447.101228297287, 5544.86137846549, 5568.1091025435735, 5595.496405323541, 4887.755612219375, 4908.067467181224, 4908.631852611068, 4915.139850526144, 4922.606191504671, 5896.233489646319, 5951.107333899863, 5953.434423729739, 5997.7001149942325, 6005.159277701126, 5700.429957004267, 5791.999999999915, 5829.562782791392, 5880.382559831156, 5887.5289976802605, 6020.54845886569, 6027.547933904887, 6063.5452341073715, 6080.574359794772, 6106.175666284995, 5794.072948328248, 5797.79707710245, 5799.536037117105, 5804.2744656917885, 5837.124431335334, 5743.9138412923, 5791.276090488689, 5855.209546711139, 5870.911936321044, 5923.881522369442, 5693.914591281051, 5716.42835716425, 5734.254546908875, 5739.71301434935, 5747.511461525817, 5626.549876009827, 5717.342505611908, 5718.742656580381, 5723.370429252695, 5738.971305143447, 5527.917081243704, 5605.663660180402, 5608.46719561641, 5626.099824028136, 5653.971730141488, 5702.7718891243885, 5704.971475142598, 5709.68596727184, 5721.027425337619, 5769.278840144982, 5506.944930550803, 5532.806351777668, 5595.776168953359, 5661.603687741983, 5670.036093863971], "unit": "score", "name": "dojo.html", "value": 5394.410926371267}, {"lowerIsBetter": false, "replicates": [528.5771382893687, 563.0034838336144, 572.7680289482759, 586.7330364684069, 609.5489337889962, 37691.811540942326, 39017.60982390175, 39110.80444597773, 39243.21513569727, 39312.41031384524, 42271.15457690844, 42527.0, 42787.14425711492, 42820.785896070556, 42990.7850460748, 8874.68938587148, 9160.633574657006, 9162.267018638526, 9178.495182764946, 9189.816203675922, 9053.0, 9188.770280742969, 9196.816063678722, 9203.861942070875, 9219.032001639833, 9286.396384235037, 9311.72064838056, 9315.161635452809, 9326.114019168168, 9360.0, 9152.45085294881, 9254.491002994799, 9255.861162082574, 9269.72190834276, 9309.906900930971, 9239.445633262027, 9277.072292770736, 9311.76720581984, 9328.160465558132, 9356.345055846094, 44188.55811441877, 44447.777761110985, 44486.77756611196, 44517.0, 44556.77721611404, 3704.6480584344713, 3738.4953031340965, 4039.7374170679104, 4142.875713728593, 4349.086691794695, 29025.56461653077, 29486.26284342887, 29800.0, 33853.830730846435, 34710.13224669403, 4206.852760153411, 4226.556211597799, 4251.087632069609, 4326.199653064194, 4369.453818272716, 245144.0, 247690.0, 248299.0, 248760.0, 248947.0210595778, 46794.0, 63318.0, 63666.0, 64299.678501607195, 64310.0, 44404.555954440686, 44526.0, 44575.10849783051, 44604.330935036, 44775.0, 16490.0, 16627.25177366997, 16667.083310418042, 16743.83256167447, 16776.161191940355, 13310.800337994939, 13423.530176443974, 13449.058565900488, 13513.864861351458, 13514.459421623222, 15675.216239188223, 15693.21533923322, 16228.107454089903, 16289.51131466058, 16383.508494745176, 5942.7920022799, 6108.602940808833, 6137.324894261627, 6239.875202496016, 6253.437190652863, 1041.8437234414746, 1075.5160177919968, 1147.1396452660504, 1153.146671463128, 1153.5904753812445, 30548.0, 30657.0, 30697.846510767304, 30862.537061944087, 31252.531212031838, 1145.4673576786834, 1169.3393232823428, 1171.812509998396, 1211.5396149463147, 1237.4369661803858, 15723.528294151194, 15956.441524546584, 16212.189390530426, 16265.0, 16451.25969331383, 356508.0, 567008.0, 568081.0, 575520.0, 843463.0, 57822.7108864453, 58433.0, 58490.0, 58504.4149558499, 58524.122138167964, 1510.4864346122372, 1533.9923300383427, 1535.7619568966604, 1536.4622382166376, 1544.289626771675, 32189.517157243128, 32732.509012364357, 32871.17822054468, 32902.50646240356, 33593.49609755807, 51619.0, 52139.47860521346, 52253.0, 52296.21555676592, 52386.73806630942, 308953.0, 309507.0, 309521.0, 310731.0, 311040.0, 36223.27553448969, 36317.092072697335, 36621.0, 36847.63152368549, 36927.44608830923, 47405.0, 47666.76166619144, 48651.72238350416, 49035.26447103225, 49385.25922111243, 40657.79671101626, 40782.796086020564, 42096.789516052224, 42276.0, 42607.78696106624, 40769.79615101906, 40949.795251023555, 41501.169976600904, 41640.375394369716, 42125.789371052946, 40136.59863401445, 40137.0, 40734.592654074266, 40864.1827163461, 41014.589854101076, 34720.305593887475, 34904.0, 35136.82431587928, 35283.0, 35562.64437355697, 27478.0, 28084.578731319456, 28231.858840705667, 28373.43253134967, 28390.148295551167], "unit": "score", "name": "ext.html", "value": 19822.707458420096}, {"lowerIsBetter": false, "replicates": [375.4593385524844, 384.88838236911295, 391.9784411857348, 392.9705272104591, 397.8945579421452, 17328.913355433222, 18608.720869186975, 18908.527286817818, 19094.71357929632, 19155.61688766224, 18565.257389704395, 18735.883804162768, 18977.715334269997, 18977.90511047446, 19000.61998760024, 5636.549076073915, 5818.767249310023, 5840.328362238354, 5857.589968702171, 5867.794627188049, 5329.946700532983, 5552.5280351170195, 5588.497035266825, 5588.804391846286, 5594.384617692051, 5551.306086739158, 5566.137248726433, 5654.0, 6317.115603815447, 6325.33583973683, 6244.3755624437645, 6248.125262463259, 6252.87494250117, 6262.467690246334, 6267.2165979252595, 5527.281453411071, 5551.028570000274, 5588.273524441796, 5611.859703507404, 5661.348944871352, 20675.0, 20991.16035358599, 21353.679694804592, 22238.99924503401, 22287.21994730193, 2316.733575638806, 2407.4703565215623, 2507.8119141064312, 2522.583773677341, 3144.4654408750566, 10625.884282150417, 10645.78708425827, 10678.0, 11282.0, 12760.872391276062, 1883.2843519462654, 1888.9622207555772, 1915.1286164794985, 1929.411529483507, 1979.3369221310877, 62495.0, 65963.0, 66592.0, 67566.66216668935, 67715.32284677139, 11143.777124457465, 11182.105431565455, 11369.886301136883, 11378.03286720638, 11528.538858445569, 15068.698626027419, 15070.698586028218, 15213.087214767149, 15236.781057515373, 15245.313960871787, 7864.252895974873, 8003.439759216799, 8103.837923241502, 8172.346212303001, 8183.14077021916, 7735.9613201933635, 7815.983922090092, 8248.340132789363, 8304.501729896225, 8436.0, 4156.355764856452, 4436.0462500562535, 4551.271796512542, 4685.273782563708, 4898.559129678275, 1860.7394964704952, 1979.8416126709828, 1981.3758666020158, 2009.9095540700703, 2030.319842852661, 995.5569771451779, 1001.6093723447862, 1005.7234260578399, 1019.90820826126, 1081.648464249122, 16711.331546737994, 17704.734428983575, 17739.556511087325, 18094.547636308933, 18288.54278643018, 1022.99488502557, 1068.2415485005577, 1077.65515035188, 1089.3953855610212, 1107.341132026443, 10100.595976161017, 10725.946370268099, 10749.677509674722, 10778.029977301923, 10818.567257309776, 475684.86472702934, 480682.0, 483337.0, 490560.0, 494147.0, 80523.0, 83433.0, 84412.57793710992, 84428.0, 84871.0, 1010.5856598794459, 1113.3932007056335, 1116.1461481966303, 1116.5031560955297, 1120.882307357732, 16403.42588009414, 16439.0, 16473.83526164723, 16687.415940442028, 16929.49211523607, 33189.50215746814, 33540.49689254614, 34107.65892341045, 35746.28507429889, 36306.0, 41962.79018604887, 43039.784801075795, 43480.13039739251, 43588.78205608952, 44284.0, 8149.877751833846, 8187.877181842397, 8302.87545686803, 8367.28878045373, 8429.283510901641, 12579.496820127093, 13308.800367994294, 13339.599812005656, 13406.262655553648, 13498.122622029538, 5730.541556675373, 7912.4856884302335, 9710.320277580502, 12068.939655302018, 12182.451789669309, 11949.10381721357, 12127.575534856238, 12141.878581214074, 12418.316992565135, 12422.316772577595, 6705.6647167642395, 6709.027191057172, 12273.815892761795, 12437.378131093228, 12600.810987835373, 8435.620397082268, 8608.139186081342, 8626.525541095049, 8655.3508486865, 8885.155910188521, 8974.551272436222, 10898.0, 11141.0, 11337.433128343715, 11481.196316257781], "unit": "score", "name": "jquery.html", "value": 8965.61256590813}, {"lowerIsBetter": false, "replicates": [1585.556044307594, 1602.0788046873047, 1854.1934258597512, 1903.4194570655961, 1957.3247229705755, 7855.764327070183, 8469.44948578342, 8507.702230421937, 8692.826143477134, 8737.737867863967, 8641.567921603926, 8643.611037503311, 8709.956450217756, 8718.60766265518, 8727.476351418904, 2434.233216536785, 2460.9753902460925, 2462.741412151725, 2469.086438017936, 2471.295680730992, 2426.599611064172, 2503.6244563315468, 2522.318973877052, 2525.5201511712808, 2527.128140791433, 2406.9879650601724, 2416.3838221253645, 2506.862122583257, 2513.42191296002, 2515.182565666166, 2493.5885578879643, 2501.249625112459, 2511.259178542316, 2515.6855393075866, 2524.1039431002005, 2449.3386785567795, 2471.2462698876834, 2475.0, 2475.851448913053, 2538.1750930947333, 8947.64209431622, 8955.37312388133, 8960.820783584357, 8977.820443591092, 8990.145936136056, 5395.460453954613, 5504.091824848895, 5506.834794956158, 5507.256520369779, 5511.779528818843, 3267.15054085937, 3336.5495658086334, 3376.5948086229564, 3401.9659803402146, 3439.7420193485586, 947.4367293964945, 1122.960696375623, 1129.446571180124, 1134.0927258193494, 1142.520141540555, 12661.873381266161, 12693.809592856207, 12700.745985080246, 12703.555375561904, 12705.555305564354, 4750.786214620351, 4804.519548045238, 4835.298881662139, 4839.927401088987, 4997.375328083989, 10716.624918127829, 10752.086072683753, 10774.4074075925, 10777.299475534066, 10808.945955270174, 5446.21029950655, 5489.3687225969525, 5492.176173573996, 5495.6153069284765, 5532.695701736443, 4777.235642297285, 4867.756612169377, 4920.778564964585, 4946.183879659888, 4983.50164983506, 3843.865464708722, 3867.149227170018, 3896.6103389660807, 3897.142628621699, 3923.097687531884, 1164.2665120973732, 1168.5209064283604, 1178.675864137369, 1179.7994340962057, 1193.0574845871665, 1222.8165775133623, 1250.662321173278, 1259.9307038112809, 1505.503183949294, 1506.7589185730449, 8307.875381869277, 8428.704995325133, 8445.282151017109, 8463.026751923608, 8483.0, 546.1893821980124, 552.9852720258291, 554.9167624856303, 562.5583916625511, 573.1946615005924, 6114.602550834271, 6118.20463339763, 6120.877582448326, 6131.540134489931, 6169.598976066542, 10682.305650132872, 11081.390523521122, 11147.0, 11180.888191117985, 11231.71920701989, 10750.623728169632, 10812.67561973142, 10888.40113793749, 11028.50371733274, 11097.83353249702, 8384.329253659693, 8460.111688272766, 8484.36367272457, 8494.830103397897, 8534.53060081689, 7986.680532778856, 7992.800179995546, 7998.880016799869, 8094.10964793884, 8162.020557533134, 9311.0, 9349.25205983506, 9392.906070939476, 9682.128608425275, 9769.511524423608, 9730.41617502952, 9786.070323319273, 10068.748281293027, 10099.293049486465, 10119.59521619127, 7815.179406162271, 7830.843383132419, 7957.681692732226, 8246.463979841292, 8261.463004904663, 8417.410781245255, 8427.241548260687, 8441.95779021101, 8442.029166645914, 8452.070272270168, 7439.516431432156, 7732.613369331623, 7734.690612375442, 7756.767296981099, 7963.721269755531, 7565.243475652391, 7681.0, 7724.961375193088, 7852.13626501073, 7860.3318717909615, 7924.84150317002, 7955.403344749051, 7973.800654983672, 7980.8802867955865, 8029.0, 6990.300969902969, 7057.258987806412, 7091.964540177266, 7106.893396598952, 7123.536970096927, 7540.434467414856, 7551.169371369255, 7552.055993000875, 7556.168821429528, 7596.430267730053], "unit": "score", "name": "mootools.html", "value": 4942.312615665015}, {"lowerIsBetter": false, "replicates": [362.51785125782703, 367.94480827875816, 370.0637387409854, 370.5090754749957, 380.4863434363611, 6398.680065996699, 6445.291017988017, 6446.935530644692, 6479.416852483276, 6519.641419721914, 6386.361363863612, 6396.6481843498705, 6399.648019358933, 6400.039994000902, 6400.583962042464, 4732.90534189316, 4842.975785121087, 4893.730844803535, 4907.2639104134305, 4944.876378090549, 4880.511948805127, 4888.926666100011, 4889.217725163974, 4900.191468407708, 4923.236898280755, 4856.2958371036175, 4862.829800956967, 4864.586510146642, 4864.878378040559, 4879.243717223836, 4854.927176092361, 4855.101806165871, 4869.464358920533, 4885.828995985159, 4891.9755401222765, 4276.700630955835, 4281.100968796556, 4288.76411797351, 4294.184105020067, 4295.506016808075, 5929.644221346733, 6085.452309292141, 6087.4521293083835, 6088.391160883921, 6090.512758979271, 5689.943100568983, 5704.714764261812, 5705.6291341063115, 5711.514521265697, 5715.657060576379, 6724.764633237862, 6725.764598239038, 6758.155230596176, 6763.188417389895, 6801.251862295144, 4680.602148817355, 4690.179218636725, 4698.365720627706, 4705.5764981151515, 4715.834945776915, 6990.231074581792, 7028.718851245944, 7058.576485410892, 7066.364027237573, 7087.0, 4712.128256272532, 4776.188048031843, 4779.737114458738, 4782.952170478251, 4831.492693267156, 4881.4630390657, 4905.7301848397965, 4911.877203069952, 4916.311716359713, 4921.089598424232, 5655.434456554394, 5658.264425624725, 5663.433656634304, 5672.432756724294, 5673.035583950738, 6757.358050985148, 6788.049673045777, 6789.898151527731, 6794.184697836291, 6818.4886133540185, 1721.0964243771868, 1741.0337262819003, 1741.8606511479052, 1741.947741567755, 1743.2155530011546, 1090.9781804363868, 1135.4095870147478, 1136.4601814138384, 1137.766757814646, 1144.0447226565911, 6512.446442052384, 6521.08704781331, 6525.086487891699, 6527.5757075789925, 6529.053287273414, 7042.542234754725, 7054.400375967997, 7059.6117213552725, 7063.081799366049, 7072.611006394594, 6316.115743795872, 6373.840653983595, 6510.44661203803, 6581.2760596334365, 6598.637074960923, 3840.7503512272174, 3846.076941534012, 3852.9036774080873, 3859.517560304962, 3871.709621778378, 7323.560586364835, 7325.597092159983, 7326.084239470067, 7352.669129889167, 7370.8894366584545, 7197.064381630459, 7255.201927787939, 7266.45501587383, 7273.418126549864, 7274.56352618834, 7174.784756457315, 7299.0, 7361.705531778776, 7368.189499155089, 7377.188509263977, 7080.0, 7110.0, 7110.537815042006, 7116.964415177891, 7131.037309963089, 6967.7212911482975, 6968.128983877015, 6970.23327433992, 6973.65131743421, 6982.476314276348, 7304.707811687473, 7307.488475806643, 7347.044884165024, 7349.412047036118, 7350.852982940418, 4759.476457589732, 4844.75776211181, 4884.82903098404, 4886.560209581013, 4901.215805471107, 7016.719331226694, 7054.717811287491, 7086.291370862872, 7087.0, 7089.184743754328, 6849.794506164823, 6867.3476019778045, 6871.175458944958, 6871.209810871814, 6878.071460352789, 6856.794296171123, 6864.24493305746, 6875.4155896749335, 6878.105846239957, 6882.965585172042, 6581.835454113685, 6729.158855143107, 6781.660916954232, 6788.66056697173, 6791.219009813737, 6905.136857892763, 6914.965425172842, 6929.826754331182, 6949.061876646588, 6953.75661851853, 6768.9661551691925, 6771.0, 6773.89839152423, 6783.830404239933, 6824.249332573314], "unit": "score", "name": "prototype.html", "value": 5150.482283266596}, {"lowerIsBetter": false, "replicates": [775.6083177995114, 790.229526211943, 863.443079213907, 912.2610685344871, 913.9954300228497, 14721.484748033821, 14900.925495372509, 14907.254637268134, 14921.626959326022, 14938.551843444688, 14172.716545669105, 14285.357158927847, 14285.642858928506, 14387.1367717937, 14416.558344165578, 782.8395178988308, 905.6467977488785, 922.9723108306762, 929.3866048408051, 932.953352332384, 939.7791518993065, 942.4533770413178, 942.7501712046313, 945.078548415293, 948.7485816258662, 1001.1790331927822, 1003.4882210072842, 1005.1054561440324, 1010.4695035106591, 1011.0193112680688, 981.7251169672503, 983.2822039910869, 987.1757082835769, 987.2595553334999, 987.5309228116658, 734.7832389445126, 736.3740820302753, 737.7823542055106, 738.4129616954534, 738.8226825561826, 13378.598642040753, 13455.529056482976, 13465.124766890121, 13560.45758169672, 13639.659008524766, 13956.651083722887, 14116.858831411657, 14218.715625687428, 14272.928635356757, 14331.641708957255, 11668.241564298378, 11717.23837950539, 11795.29228246308, 11832.940835295769, 11972.521099156023, 3942.448057271984, 3976.1252524444576, 3978.8209530570903, 3983.98008009961, 4001.0397504598977, 48512.51487485115, 49129.50870491285, 49398.50601493975, 49433.25850112251, 52634.0, 9827.55775990068, 10047.196224302039, 10047.447390393452, 10183.745406364753, 11130.721731956766, 17645.117744112744, 17739.11304434773, 17743.467695969142, 17845.37541186052, 17861.0, 8052.436329456999, 8191.918080819235, 8274.627641756015, 8282.917170828336, 8298.543580103153, 4587.61005314552, 4705.458872229738, 4727.2436410174205, 4809.639277054235, 4911.8280860169725, 3425.554677891908, 3460.602030766444, 3466.30673865228, 3509.842057107436, 3537.4163263061305, 654.564714464885, 660.3462572053728, 662.8011596521025, 663.3167837127767, 670.8859493886051, 622.4149299658307, 624.8031869961038, 651.9698875776262, 662.8641128568631, 764.2090436398302, 9057.864132038025, 9267.304952128618, 9350.812983740287, 9355.719328420158, 9428.340016198801, 580.3297191743543, 668.7224801707237, 713.932176443237, 728.4572993120054, 758.4577027425418, 4051.7974101294817, 4146.792660366969, 4175.645070169009, 4221.915561688749, 4339.7613131278085, 60108.699456502436, 60883.39116608866, 61121.38878611246, 61239.69380153071, 61405.0, 51580.0, 51749.741251293504, 51767.7411612947, 52474.47525524772, 55896.720516397974, 46461.76769116133, 46538.0, 47440.0, 47582.762086189345, 48029.51970480251, 8309.95845020771, 8395.580220989048, 8499.83000340002, 8546.78633034179, 8555.401121921655, 35004.82497587496, 35837.462438062925, 36606.267874641824, 36626.26747465089, 37161.0, 41811.0, 42299.7885010573, 47210.76394618005, 47486.0, 48535.0, 11329.093672506344, 11348.0, 11536.769264614493, 11592.072634189077, 11625.18623696367, 10941.343519388862, 11411.315321080761, 12057.51769929228, 12476.313802740937, 12713.046521511109, 11241.100711943189, 11510.136739744385, 11556.537738490366, 11849.585264515701, 12024.519019239133, 11844.940775296069, 11846.822297665369, 12053.035757139232, 12096.637100886988, 12148.0, 10900.454977250947, 10935.56257749681, 10939.343639381663, 11004.834927476255, 11331.206815522833, 9523.619055237712, 9653.613855445985, 9681.70954871355, 9814.06766357195, 9882.950585247028, 9615.471149086867, 9870.210383169473, 9949.403035817873, 9960.701178964642, 9995.150412215044], "unit": "score", "name": "yui.html", "value": 6726.3138215658155}], "name": "dromaeo_css", "value": 7399.6800856546}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 107.0, 111.0, 113.0, 112.0, 124.0, 113.0, 112.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [161.0, 134.0, 155.0, 174.0, 128.0, 155.0, 163.0, 130.0, 176.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 163.0, 164.0, 161.0, 161.0, 162.0, 163.0, 165.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 76.0, 166.0, 75.0, 76.0, 75.0, 73.0, 170.0, 73.0], "unit": "score", "name": "audio-fft", "value": 93.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 149.0, 94.0, 93.0, 94.0, 149.0, 93.0, 94.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 58.0, 56.0, 56.0, 57.0, 56.0, 60.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 82.0, 82.0, 82.0, 82.0, 83.0, 83.0, 85.0, 84.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 82.9}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 88.0, 79.0, 79.0, 79.0, 82.0, 85.0, 80.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.7}, {"lowerIsBetter": true, "replicates": [115.0, 115.0, 114.0, 118.0, 116.0, 119.0, 120.0, 123.0, 116.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.0}, {"lowerIsBetter": true, "replicates": [147.0, 139.0, 146.0, 146.0, 145.0, 145.0, 144.0, 149.0, 139.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.2}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 66.0, 66.0, 66.0, 68.0, 66.0, 68.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1536.2}]} 09:30:15 INFO - Return code: 0 09:30:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:30:15 ERROR - # TBPL SUCCESS # 09:30:15 INFO - Running post-action listener: _resource_record_post_action 09:30:15 INFO - Running post-run listener: _resource_record_post_run 09:30:16 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 459100160; Read time: 0; Write time: 333108 09:30:16 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 233574400; Read time: 0; Write time: 221936 09:30:16 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 221130752; Read time: 0; Write time: 110644 09:30:16 INFO - Running post-run listener: _upload_blobber_files 09:30:16 INFO - Blob upload gear active. 09:30:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:30:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:30:16 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'] 09:30:16 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 09:30:16 INFO - (blobuploader) - INFO - Open directory for files ... 09:30:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:30:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:30:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:30:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:30:17 INFO - (blobuploader) - INFO - Done attempting. 09:30:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:30:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:30:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:30:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:30:18 INFO - (blobuploader) - INFO - Done attempting. 09:30:18 INFO - (blobuploader) - INFO - Iteration through files over. 09:30:18 INFO - Return code: 0 09:30:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:30:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:30:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9312865b3c5da1354a20b05aba5e131aee54f4d5517dc2a77881ee7090d8c1b9a16d9621889b5c71d37cff5526e37b865255df32b870424531548a4d0fdcab90", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ee5030e66d6ba1d073ad187ebcf2aba09eb62d87aca7bf85dc6715aa0cc0ad8494e85bf07e6eb4635f7498e22ca7c9b6dc967c9445786dcef71c357fe6cf49b"} 09:30:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:30:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:30:18 INFO - Contents: 09:30:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9312865b3c5da1354a20b05aba5e131aee54f4d5517dc2a77881ee7090d8c1b9a16d9621889b5c71d37cff5526e37b865255df32b870424531548a4d0fdcab90", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ee5030e66d6ba1d073ad187ebcf2aba09eb62d87aca7bf85dc6715aa0cc0ad8494e85bf07e6eb4635f7498e22ca7c9b6dc967c9445786dcef71c357fe6cf49b"} 09:30:18 INFO - Running post-run listener: copy_logs_to_upload_dir 09:30:18 INFO - Copying logs to upload dir... 09:30:18 INFO - mkdir: /builds/slave/test/build/upload/logs 09:30:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.243320 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-06 09:30:17.563330) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 09:30:17.567132) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989 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/9312865b3c5da1354a20b05aba5e131aee54f4d5517dc2a77881ee7090d8c1b9a16d9621889b5c71d37cff5526e37b865255df32b870424531548a4d0fdcab90", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ee5030e66d6ba1d073ad187ebcf2aba09eb62d87aca7bf85dc6715aa0cc0ad8494e85bf07e6eb4635f7498e22ca7c9b6dc967c9445786dcef71c357fe6cf49b"} build_url:https://queue.taskcluster.net/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/HGUSB3b-SUaWoxmtJ7ISyg/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/9312865b3c5da1354a20b05aba5e131aee54f4d5517dc2a77881ee7090d8c1b9a16d9621889b5c71d37cff5526e37b865255df32b870424531548a4d0fdcab90", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ee5030e66d6ba1d073ad187ebcf2aba09eb62d87aca7bf85dc6715aa0cc0ad8494e85bf07e6eb4635f7498e22ca7c9b6dc967c9445786dcef71c357fe6cf49b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 09:30:17.596339) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:30:17.596686) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1462550018.415848-374707989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:30:17.678767) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 09:30:17.679074) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 09:30:17.679353) ========= ========= Total master_lag: 0.18 =========