builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1461652052.96 results: success (0) buildid: 20160425205003 builduid: 68a02e46d6d349f3b74437b25b685305 revision: 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 23:27:32.964644) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 23:27:32.965091) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 23:27:32.965372) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 23:27:32.995423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 23:27:32.995681) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 23:27:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.9M=0s 2016-04-25 23:27:33 (26.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111667 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 23:27:33.119946) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 23:27:33.120238) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018386 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 23:27:33.169478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 23:27:33.169792) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 --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 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 --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=5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 23:27:33,298 truncating revision to first 12 chars 2016-04-25 23:27:33,298 Setting DEBUG logging. 2016-04-25 23:27:33,298 attempt 1/10 2016-04-25 23:27:33,298 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5bbf2e7c2fc6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 23:27:34,485 unpacking tar archive at: mozilla-beta-5bbf2e7c2fc6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.484413 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 23:27:34.667466) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 23:27:34.667855) ========= script_repo_revision: 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 23:27:34.668603) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 23:27:34.668999) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 23:27:34.678105) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-25 23:27:34.678490) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:27:34 INFO - MultiFileLogger online at 20160425 23:27:34 in /builds/slave/test 23:27:34 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 23:27:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:27:34 INFO - {'append_to_log': False, 23:27:34 INFO - 'base_work_dir': '/builds/slave/test', 23:27:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:27:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:27:34 INFO - 'branch': 'Mozilla-Beta', 23:27:34 INFO - 'buildbot_json_path': 'buildprops.json', 23:27:34 INFO - 'config_files': ('talos/linux_config.py',), 23:27:34 INFO - 'default_actions': ('clobber', 23:27:34 INFO - 'read-buildbot-config', 23:27:34 INFO - 'download-and-extract', 23:27:34 INFO - 'populate-webroot', 23:27:34 INFO - 'create-virtualenv', 23:27:34 INFO - 'install', 23:27:34 INFO - 'run-tests'), 23:27:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:27:34 INFO - 'download_minidump_stackwalk': True, 23:27:34 INFO - 'download_symbols': 'ondemand', 23:27:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:27:34 INFO - 'tooltool.py': '/tools/tooltool.py', 23:27:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:27:34 INFO - '/tools/misc-python/virtualenv.py')}, 23:27:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:27:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:27:34 INFO - 'installer_path': 'installer.exe', 23:27:34 INFO - 'log_level': 'info', 23:27:34 INFO - 'log_name': 'talos', 23:27:34 INFO - 'log_to_console': True, 23:27:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:27:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:27:34 INFO - 'opt_config_files': (), 23:27:34 INFO - 'pip_index': False, 23:27:34 INFO - 'sps_profile': False, 23:27:34 INFO - 'sps_profile_interval': 0, 23:27:34 INFO - 'suite': 'dromaeojs-e10s', 23:27:34 INFO - 'system_bits': '32', 23:27:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:27:34 INFO - 'title': 'talos-linux64-ix-051', 23:27:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:27:34 INFO - 'use_talos_json': True, 23:27:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:27:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:27:34 INFO - 'work_dir': 'build'} 23:27:34 INFO - ##### 23:27:34 INFO - ##### Running clobber step. 23:27:34 INFO - ##### 23:27:34 INFO - Running pre-action listener: _resource_record_pre_action 23:27:34 INFO - Running main action method: clobber 23:27:34 INFO - rmtree: /builds/slave/test/build 23:27:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:27:35 INFO - Running post-action listener: _resource_record_post_action 23:27:35 INFO - ##### 23:27:35 INFO - ##### Running read-buildbot-config step. 23:27:35 INFO - ##### 23:27:35 INFO - Running pre-action listener: _resource_record_pre_action 23:27:35 INFO - Running main action method: read_buildbot_config 23:27:35 INFO - Using buildbot properties: 23:27:35 INFO - { 23:27:35 INFO - "project": "", 23:27:35 INFO - "product": "firefox", 23:27:35 INFO - "script_repo_revision": "production", 23:27:35 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 23:27:35 INFO - "repository": "", 23:27:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 23:27:35 INFO - "buildid": "20160425205003", 23:27:35 INFO - "pgo_build": "True", 23:27:35 INFO - "basedir": "/builds/slave/test", 23:27:35 INFO - "buildnumber": 62, 23:27:35 INFO - "slavename": "talos-linux64-ix-051", 23:27:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:27:35 INFO - "platform": "ubuntu64_hw", 23:27:35 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 23:27:35 INFO - "branch": "mozilla-beta", 23:27:35 INFO - "repo_path": "releases/mozilla-beta", 23:27:35 INFO - "revision": "5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2", 23:27:35 INFO - "stage_platform": "linux64-pgo", 23:27:35 INFO - "builduid": "68a02e46d6d349f3b74437b25b685305", 23:27:35 INFO - "slavebuilddir": "test" 23:27:35 INFO - } 23:27:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 23:27:35 INFO - Running post-action listener: _resource_record_post_action 23:27:35 INFO - ##### 23:27:35 INFO - ##### Running download-and-extract step. 23:27:35 INFO - ##### 23:27:35 INFO - Running pre-action listener: _resource_record_pre_action 23:27:35 INFO - Running main action method: download_and_extract 23:27:35 INFO - mkdir: /builds/slave/test/build/tests 23:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:35 INFO - https://queue.taskcluster.net/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:27:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 23:27:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 23:27:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/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 23:27:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/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 23:27:36 INFO - Downloaded 1412 bytes. 23:27:36 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 23:27:36 INFO - Using the following test package requirements: 23:27:36 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 23:27:36 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 23:27:36 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 23:27:36 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 23:27:36 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 23:27:36 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 23:27:36 INFO - u'jsshell-linux-x86_64.zip'], 23:27:36 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 23:27:36 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 23:27:36 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 23:27:36 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 23:27:36 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 23:27:36 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 23:27:36 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 23:27:36 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 23:27:36 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 23:27:36 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 23:27:36 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 23:27:36 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 23:27:36 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:36 INFO - https://queue.taskcluster.net/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:27:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 23:27:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 23:27:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/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 23:27:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/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 23:27:37 INFO - Downloaded 23363259 bytes. 23:27:37 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'] 23:27:37 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 23:27:38 INFO - Return code: 0 23:27:38 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 23:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:38 INFO - https://queue.taskcluster.net/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:27:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 23:27:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 23:27:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/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 23:27:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/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 23:27:51 INFO - Downloaded 23363259 bytes. 23:27:51 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'] 23:27:51 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 23:27:52 INFO - Return code: 0 23:27:52 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')]} 23:27:52 INFO - https://queue.taskcluster.net/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:27:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 23:27:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 23:27:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/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 23:27:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/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 23:27:54 INFO - Downloaded 10845194 bytes. 23:27:54 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'] 23:27:54 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 23:27:54 INFO - Return code: 0 23:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:54 INFO - https://queue.taskcluster.net/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:27:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 23:27:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 23:27:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/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 23:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/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 23:27:55 INFO - Downloaded 53786059 bytes. 23:27:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 23:27:55 INFO - mkdir: /builds/slave/test/properties 23:27:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:27:55 INFO - Writing to file /builds/slave/test/properties/build_url 23:27:55 INFO - Contents: 23:27:55 INFO - build_url:https://queue.taskcluster.net/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 23:27:56 INFO - Running post-action listener: _resource_record_post_action 23:27:56 INFO - Running post-action listener: set_extra_try_arguments 23:27:56 INFO - ##### 23:27:56 INFO - ##### Running populate-webroot step. 23:27:56 INFO - ##### 23:27:56 INFO - Running pre-action listener: _resource_record_pre_action 23:27:56 INFO - Running main action method: populate_webroot 23:27:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:27:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:27:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:27:56 INFO - '--tppagecycles', 23:27:56 INFO - '7'], 23:27:56 INFO - 'tests': ['tsvgm']}}, 23:27:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:27:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:27:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:27:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 23:27:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:27:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:27:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:27:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:56 INFO - 'talos_options': ['--e10s'], 23:27:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:27:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:56 INFO - 'tests': ['damp', 'tps']}, 23:27:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:56 INFO - 'talos_options': ['--e10s'], 23:27:56 INFO - 'tests': ['damp', 'tps']}, 23:27:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:27:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:27:56 INFO - 'other': {'tests': ['a11yr', 23:27:56 INFO - 'ts_paint', 23:27:56 INFO - 'tpaint', 23:27:56 INFO - 'sessionrestore', 23:27:56 INFO - 'sessionrestore_no_auto_restore', 23:27:56 INFO - 'tabpaint']}, 23:27:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:27:56 INFO - 'tests': ['a11yr', 23:27:56 INFO - 'ts_paint', 23:27:56 INFO - 'tpaint', 23:27:56 INFO - 'sessionrestore', 23:27:56 INFO - 'sessionrestore_no_auto_restore', 23:27:56 INFO - 'tabpaint']}, 23:27:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:27:56 INFO - 'tests': ['a11yr', 23:27:56 INFO - 'ts_paint', 23:27:56 INFO - 'tpaint', 23:27:56 INFO - 'sessionrestore', 23:27:56 INFO - 'sessionrestore_no_auto_restore', 23:27:56 INFO - 'tabpaint']}, 23:27:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:27:56 INFO - 'tests': ['a11yr', 23:27:56 INFO - 'ts_paint', 23:27:56 INFO - 'tpaint', 23:27:56 INFO - 'sessionrestore', 23:27:56 INFO - 'sessionrestore_no_auto_restore', 23:27:56 INFO - 'tabpaint']}, 23:27:56 INFO - 'other_l64': {'tests': ['a11yr', 23:27:56 INFO - 'ts_paint', 23:27:56 INFO - 'tpaint', 23:27:56 INFO - 'sessionrestore', 23:27:56 INFO - 'sessionrestore_no_auto_restore', 23:27:56 INFO - 'tabpaint']}, 23:27:56 INFO - 'other_nol64': {'tests': ['a11yr', 23:27:56 INFO - 'ts_paint', 23:27:56 INFO - 'tpaint', 23:27:56 INFO - 'sessionrestore', 23:27:56 INFO - 'sessionrestore_no_auto_restore', 23:27:56 INFO - 'tabpaint']}, 23:27:56 INFO - 'svgr': {'tests': ['tsvgx', 23:27:56 INFO - 'tsvgr_opacity', 23:27:56 INFO - 'tart', 23:27:56 INFO - 'tscrollx', 23:27:56 INFO - 'cart']}, 23:27:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:27:56 INFO - 'tests': ['tsvgx', 23:27:56 INFO - 'tsvgr_opacity', 23:27:56 INFO - 'tart', 23:27:56 INFO - 'tscrollx', 23:27:56 INFO - 'cart']}, 23:27:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:56 INFO - 'tests': ['tp5o']}, 23:27:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:56 INFO - 'talos_options': ['--e10s'], 23:27:56 INFO - 'tests': ['tp5o']}, 23:27:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:56 INFO - 'talos_options': ['--xperf_path', 23:27:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:27:56 INFO - 'tests': ['tp5n']}, 23:27:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:56 INFO - 'talos_options': ['--e10s', 23:27:56 INFO - '--xperf_path', 23:27:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:27:56 INFO - 'tests': ['tp5n']}}, 23:27:56 INFO - 'talos.zip': {'path': '', 23:27:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:27:56 INFO - Running post-action listener: _resource_record_post_action 23:27:56 INFO - ##### 23:27:56 INFO - ##### Running create-virtualenv step. 23:27:56 INFO - ##### 23:27:56 INFO - Running pre-action listener: _resource_record_pre_action 23:27:56 INFO - Running main action method: create_virtualenv 23:27:56 INFO - Creating virtualenv /builds/slave/test/build/venv 23:27:56 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 23:27:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:27:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:27:56 INFO - Using real prefix '/usr' 23:27:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:27:57 INFO - Installing distribute.............................................................................................................................................................................................done. 23:27:59 INFO - Installing pip.................done. 23:27:59 INFO - Return code: 0 23:27:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:27:59 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')]} 23:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:59 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')]} 23:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:59 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 0x7f98808b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d160>, '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 0x137e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e4f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', '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 23:27:59 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 23:27:59 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 23:27:59 INFO - Using env: {'DISPLAY': ':0', 23:27:59 INFO - 'HOME': '/home/cltbld', 23:27:59 INFO - 'LANG': 'en_US.UTF-8', 23:27:59 INFO - 'LANGUAGE': 'en_US:en', 23:27:59 INFO - 'LOGNAME': 'cltbld', 23:27:59 INFO - 'MAIL': '/var/mail/cltbld', 23:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:59 INFO - 'MOZ_NO_REMOTE': '1', 23:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:59 INFO - 'NO_EM_RESTART': '1', 23:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:59 INFO - 'PWD': '/builds/slave/test', 23:27:59 INFO - 'SHELL': '/bin/bash', 23:27:59 INFO - 'SHLVL': '1', 23:27:59 INFO - 'TERM': 'linux', 23:27:59 INFO - 'TMOUT': '86400', 23:27:59 INFO - 'USER': 'cltbld', 23:27:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', 23:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:59 INFO - '_': '/tools/buildbot/bin/python'} 23:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:59 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 23:27:59 INFO - Cleaning up... 23:27:59 INFO - Return code: 0 23:27:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:27:59 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')]} 23:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:59 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')]} 23:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:59 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 0x7f98808b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d160>, '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 0x137e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e4f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', '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 23:27:59 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 23:27:59 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 23:27:59 INFO - Using env: {'DISPLAY': ':0', 23:27:59 INFO - 'HOME': '/home/cltbld', 23:27:59 INFO - 'LANG': 'en_US.UTF-8', 23:27:59 INFO - 'LANGUAGE': 'en_US:en', 23:27:59 INFO - 'LOGNAME': 'cltbld', 23:27:59 INFO - 'MAIL': '/var/mail/cltbld', 23:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:59 INFO - 'MOZ_NO_REMOTE': '1', 23:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:59 INFO - 'NO_EM_RESTART': '1', 23:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:59 INFO - 'PWD': '/builds/slave/test', 23:27:59 INFO - 'SHELL': '/bin/bash', 23:27:59 INFO - 'SHLVL': '1', 23:27:59 INFO - 'TERM': 'linux', 23:27:59 INFO - 'TMOUT': '86400', 23:27:59 INFO - 'USER': 'cltbld', 23:27:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', 23:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:59 INFO - '_': '/tools/buildbot/bin/python'} 23:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:59 INFO - Downloading/unpacking psutil>=0.7.1 23:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:28:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:28:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:28:01 INFO - Installing collected packages: psutil 23:28:01 INFO - Running setup.py install for psutil 23:28:01 INFO - building 'psutil._psutil_linux' extension 23:28:01 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 23:28:01 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 23:28:01 INFO - building 'psutil._psutil_posix' extension 23:28:01 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 23:28:01 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 23:28:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:28:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:28:02 INFO - Successfully installed psutil 23:28:02 INFO - Cleaning up... 23:28:02 INFO - Return code: 0 23:28:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f98808b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d160>, '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 0x137e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e4f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', '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 23:28:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:28:02 INFO - Using env: {'DISPLAY': ':0', 23:28:02 INFO - 'HOME': '/home/cltbld', 23:28:02 INFO - 'LANG': 'en_US.UTF-8', 23:28:02 INFO - 'LANGUAGE': 'en_US:en', 23:28:02 INFO - 'LOGNAME': 'cltbld', 23:28:02 INFO - 'MAIL': '/var/mail/cltbld', 23:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:02 INFO - 'MOZ_NO_REMOTE': '1', 23:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:28:02 INFO - 'NO_EM_RESTART': '1', 23:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:28:02 INFO - 'PWD': '/builds/slave/test', 23:28:02 INFO - 'SHELL': '/bin/bash', 23:28:02 INFO - 'SHLVL': '1', 23:28:02 INFO - 'TERM': 'linux', 23:28:02 INFO - 'TMOUT': '86400', 23:28:02 INFO - 'USER': 'cltbld', 23:28:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', 23:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:28:02 INFO - '_': '/tools/buildbot/bin/python'} 23:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:28:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:28:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:28:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:28:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:28:04 INFO - Installing collected packages: mozsystemmonitor 23:28:04 INFO - Running setup.py install for mozsystemmonitor 23:28:04 INFO - Successfully installed mozsystemmonitor 23:28:04 INFO - Cleaning up... 23:28:05 INFO - Return code: 0 23:28:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:28: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')]} 23:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:28:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28: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')]} 23:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:28:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f98808b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d160>, '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 0x137e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e4f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', '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 23:28:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:28:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:28:05 INFO - Using env: {'DISPLAY': ':0', 23:28:05 INFO - 'HOME': '/home/cltbld', 23:28:05 INFO - 'LANG': 'en_US.UTF-8', 23:28:05 INFO - 'LANGUAGE': 'en_US:en', 23:28:05 INFO - 'LOGNAME': 'cltbld', 23:28:05 INFO - 'MAIL': '/var/mail/cltbld', 23:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:05 INFO - 'MOZ_NO_REMOTE': '1', 23:28:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:28:05 INFO - 'NO_EM_RESTART': '1', 23:28:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:28:05 INFO - 'PWD': '/builds/slave/test', 23:28:05 INFO - 'SHELL': '/bin/bash', 23:28:05 INFO - 'SHLVL': '1', 23:28:05 INFO - 'TERM': 'linux', 23:28:05 INFO - 'TMOUT': '86400', 23:28:05 INFO - 'USER': 'cltbld', 23:28:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', 23:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:28:05 INFO - '_': '/tools/buildbot/bin/python'} 23:28:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:28:05 INFO - Downloading/unpacking blobuploader==1.2.4 23:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:28:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:28:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:28:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:07 INFO - Downloading blobuploader-1.2.4.tar.gz 23:28:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:28:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:28:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:28:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:28:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:07 INFO - Downloading docopt-0.6.1.tar.gz 23:28:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:28:08 INFO - Installing collected packages: blobuploader, requests, docopt 23:28:08 INFO - Running setup.py install for blobuploader 23:28:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:28:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:28:08 INFO - Running setup.py install for requests 23:28:08 INFO - Running setup.py install for docopt 23:28:08 INFO - Successfully installed blobuploader requests docopt 23:28:08 INFO - Cleaning up... 23:28:08 INFO - Return code: 0 23:28:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:28:08 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')]} 23:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:28:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28:08 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')]} 23:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:28:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28:08 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 0x7f98808b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d160>, '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 0x137e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e4f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', '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 23:28:08 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 23:28:08 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 23:28:08 INFO - Using env: {'DISPLAY': ':0', 23:28:08 INFO - 'HOME': '/home/cltbld', 23:28:08 INFO - 'LANG': 'en_US.UTF-8', 23:28:08 INFO - 'LANGUAGE': 'en_US:en', 23:28:08 INFO - 'LOGNAME': 'cltbld', 23:28:08 INFO - 'MAIL': '/var/mail/cltbld', 23:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:08 INFO - 'MOZ_NO_REMOTE': '1', 23:28:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:28:08 INFO - 'NO_EM_RESTART': '1', 23:28:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:28:08 INFO - 'PWD': '/builds/slave/test', 23:28:08 INFO - 'SHELL': '/bin/bash', 23:28:08 INFO - 'SHLVL': '1', 23:28:08 INFO - 'TERM': 'linux', 23:28:08 INFO - 'TMOUT': '86400', 23:28:08 INFO - 'USER': 'cltbld', 23:28:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', 23:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:28:08 INFO - '_': '/tools/buildbot/bin/python'} 23:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:28:08 INFO - Running setup.py (path:/tmp/pip-XLzrdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:28:08 INFO - Running setup.py (path:/tmp/pip-KlWMUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:28:09 INFO - Running setup.py (path:/tmp/pip-qvwgWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:28:09 INFO - Running setup.py (path:/tmp/pip-qohpAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:28:09 INFO - Running setup.py (path:/tmp/pip-Gvh_gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:28:09 INFO - Running setup.py (path:/tmp/pip-Vgi4kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:28:09 INFO - Running setup.py (path:/tmp/pip-Mtaouv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:28:09 INFO - Running setup.py (path:/tmp/pip-MTdAdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:28:09 INFO - Running setup.py (path:/tmp/pip-BbloVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:28:09 INFO - Running setup.py (path:/tmp/pip-KZcdva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:28:09 INFO - Running setup.py (path:/tmp/pip-sOwajn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:28:09 INFO - Running setup.py (path:/tmp/pip-rQyyAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:28:09 INFO - Running setup.py (path:/tmp/pip-b9ZKJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:28:09 INFO - Running setup.py (path:/tmp/pip-Dn4CvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:28:09 INFO - Running setup.py (path:/tmp/pip-Fd5oOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:28:09 INFO - Running setup.py (path:/tmp/pip-gYFbPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:28:10 INFO - Running setup.py (path:/tmp/pip-LZGtIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:28:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:28:10 INFO - Running setup.py install for manifestparser 23:28:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:28:10 INFO - Running setup.py install for mozcrash 23:28:10 INFO - Running setup.py install for mozdebug 23:28:10 INFO - Running setup.py install for mozdevice 23:28:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:28:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:28:10 INFO - Running setup.py install for mozfile 23:28:10 INFO - Running setup.py install for mozhttpd 23:28:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:28:10 INFO - Running setup.py install for mozinfo 23:28:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:28:10 INFO - Running setup.py install for mozInstall 23:28:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:28:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:28:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:28:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:28:10 INFO - Running setup.py install for mozleak 23:28:10 INFO - Running setup.py install for mozlog 23:28:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:28:11 INFO - Running setup.py install for moznetwork 23:28:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:28:11 INFO - Running setup.py install for mozprocess 23:28:11 INFO - Running setup.py install for mozprofile 23:28:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:28:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:28:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:28:11 INFO - Running setup.py install for mozrunner 23:28:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:28:11 INFO - Running setup.py install for mozscreenshot 23:28:11 INFO - Running setup.py install for moztest 23:28:11 INFO - Running setup.py install for mozversion 23:28:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:28:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:28:11 INFO - Cleaning up... 23:28:11 INFO - Return code: 0 23:28:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:28:11 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')]} 23:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28:11 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')]} 23:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28:11 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 0x7f98808b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d160>, '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 0x137e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e4f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', '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 23:28:11 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 23:28:11 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 23:28:11 INFO - Using env: {'DISPLAY': ':0', 23:28:11 INFO - 'HOME': '/home/cltbld', 23:28:11 INFO - 'LANG': 'en_US.UTF-8', 23:28:11 INFO - 'LANGUAGE': 'en_US:en', 23:28:11 INFO - 'LOGNAME': 'cltbld', 23:28:11 INFO - 'MAIL': '/var/mail/cltbld', 23:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:11 INFO - 'MOZ_NO_REMOTE': '1', 23:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:28:11 INFO - 'NO_EM_RESTART': '1', 23:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:28:11 INFO - 'PWD': '/builds/slave/test', 23:28:11 INFO - 'SHELL': '/bin/bash', 23:28:11 INFO - 'SHLVL': '1', 23:28:11 INFO - 'TERM': 'linux', 23:28:11 INFO - 'TMOUT': '86400', 23:28:11 INFO - 'USER': 'cltbld', 23:28:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', 23:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:28:11 INFO - '_': '/tools/buildbot/bin/python'} 23:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:28:12 INFO - Running setup.py (path:/tmp/pip-RXLAwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:28:12 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)) 23:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:28:12 INFO - Running setup.py (path:/tmp/pip-Gozd70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:28:12 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)) 23:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:28:12 INFO - Running setup.py (path:/tmp/pip-wY7_pE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:28:12 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)) 23:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:28:12 INFO - Running setup.py (path:/tmp/pip-2m3oXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:28:12 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)) 23:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:28:12 INFO - Running setup.py (path:/tmp/pip-kxpK7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:28:12 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)) 23:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:28:12 INFO - Running setup.py (path:/tmp/pip-2ZwwhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:28:12 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)) 23:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:28:12 INFO - Running setup.py (path:/tmp/pip-AwtTRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:28:12 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)) 23:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:28:12 INFO - Running setup.py (path:/tmp/pip-R3XqpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:28:12 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)) 23:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:28:12 INFO - Running setup.py (path:/tmp/pip-vd3c9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:28:12 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)) 23:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:28:12 INFO - Running setup.py (path:/tmp/pip-PF7Esp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:28:12 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)) 23:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:28:12 INFO - Running setup.py (path:/tmp/pip-GWBCQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:28:12 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)) 23:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:28:12 INFO - Running setup.py (path:/tmp/pip-igIx6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:28:12 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)) 23:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:28:12 INFO - Running setup.py (path:/tmp/pip-G2_C3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:28:13 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)) 23:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:28:13 INFO - Running setup.py (path:/tmp/pip-Ex8kp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:28:13 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)) 23:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:28:13 INFO - Running setup.py (path:/tmp/pip-RWFHmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:28:13 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)) 23:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:28:13 INFO - Running setup.py (path:/tmp/pip-7lIJXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:28:13 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)) 23:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:28:13 INFO - Running setup.py (path:/tmp/pip-pAriIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:28:13 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)) 23:28:13 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)) 23:28:13 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)) 23:28:13 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)) 23:28:13 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)) 23:28:13 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)) 23:28:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:28: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 23:28: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 23:28: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 23:28: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 23:28: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 23:28: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 23:28:15 INFO - Downloading blessings-1.6.tar.gz 23:28:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:28:15 INFO - Installing collected packages: blessings 23:28:15 INFO - Running setup.py install for blessings 23:28:15 INFO - Successfully installed blessings 23:28:15 INFO - Cleaning up... 23:28:15 INFO - Return code: 0 23:28:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:28:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:28:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:28:15 INFO - Reading from file tmpfile_stdout 23:28:15 INFO - Current package versions: 23:28:15 INFO - argparse == 1.2.1 23:28:15 INFO - blessings == 1.6 23:28:15 INFO - blobuploader == 1.2.4 23:28:15 INFO - docopt == 0.6.1 23:28:15 INFO - manifestparser == 1.1 23:28:15 INFO - mozInstall == 1.12 23:28:15 INFO - mozcrash == 0.17 23:28:15 INFO - mozdebug == 0.1 23:28:15 INFO - mozdevice == 0.48 23:28:15 INFO - mozfile == 1.2 23:28:15 INFO - mozhttpd == 0.7 23:28:15 INFO - mozinfo == 0.9 23:28:15 INFO - mozleak == 0.1 23:28:15 INFO - mozlog == 3.1 23:28:15 INFO - moznetwork == 0.27 23:28:15 INFO - mozprocess == 0.22 23:28:15 INFO - mozprofile == 0.28 23:28:15 INFO - mozrunner == 6.11 23:28:15 INFO - mozscreenshot == 0.1 23:28:15 INFO - mozsystemmonitor == 0.0 23:28:15 INFO - moztest == 0.7 23:28:15 INFO - mozversion == 1.4 23:28:15 INFO - psutil == 3.1.1 23:28:15 INFO - requests == 1.2.3 23:28:15 INFO - wsgiref == 0.1.2 23:28:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:28: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')]} 23:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28: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')]} 23:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28:15 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 0x7f98808b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d160>, '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 0x137e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e4f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', '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 23:28:15 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 23:28:15 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 23:28:15 INFO - Using env: {'DISPLAY': ':0', 23:28:15 INFO - 'HOME': '/home/cltbld', 23:28:15 INFO - 'LANG': 'en_US.UTF-8', 23:28:15 INFO - 'LANGUAGE': 'en_US:en', 23:28:15 INFO - 'LOGNAME': 'cltbld', 23:28:15 INFO - 'MAIL': '/var/mail/cltbld', 23:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:15 INFO - 'MOZ_NO_REMOTE': '1', 23:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:28:15 INFO - 'NO_EM_RESTART': '1', 23:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:28:15 INFO - 'PWD': '/builds/slave/test', 23:28:15 INFO - 'SHELL': '/bin/bash', 23:28:15 INFO - 'SHLVL': '1', 23:28:15 INFO - 'TERM': 'linux', 23:28:15 INFO - 'TMOUT': '86400', 23:28:15 INFO - 'USER': 'cltbld', 23:28:15 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', 23:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:28:15 INFO - '_': '/tools/buildbot/bin/python'} 23:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:28:15 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)) 23:28:15 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)) 23:28:15 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)) 23:28:15 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)) 23:28:15 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)) 23:28:15 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)) 23:28:15 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)) 23:28:15 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)) 23:28:15 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)) 23:28:15 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)) 23:28:15 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)) 23:28:15 INFO - Cleaning up... 23:28:15 INFO - Return code: 0 23:28:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:28: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')]} 23:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28: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')]} 23:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98808b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d160>, '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 0x137e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e4f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', '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 23:28: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', 'jsonschema'] in /builds/slave/test/build 23:28: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 jsonschema 23:28:15 INFO - Using env: {'DISPLAY': ':0', 23:28:15 INFO - 'HOME': '/home/cltbld', 23:28:15 INFO - 'LANG': 'en_US.UTF-8', 23:28:15 INFO - 'LANGUAGE': 'en_US:en', 23:28:15 INFO - 'LOGNAME': 'cltbld', 23:28:15 INFO - 'MAIL': '/var/mail/cltbld', 23:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:15 INFO - 'MOZ_NO_REMOTE': '1', 23:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:28:15 INFO - 'NO_EM_RESTART': '1', 23:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:28:15 INFO - 'PWD': '/builds/slave/test', 23:28:15 INFO - 'SHELL': '/bin/bash', 23:28:15 INFO - 'SHLVL': '1', 23:28:15 INFO - 'TERM': 'linux', 23:28:15 INFO - 'TMOUT': '86400', 23:28:15 INFO - 'USER': 'cltbld', 23:28:15 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', 23:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:28:15 INFO - '_': '/tools/buildbot/bin/python'} 23:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:28:16 INFO - Downloading/unpacking jsonschema 23:28:16 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 23:28:16 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 23:28:16 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 23:28:16 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 23:28:16 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 23:28:16 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 23:28:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:28:17 INFO - Downloading/unpacking functools32 (from jsonschema) 23:28: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 23:28: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 23:28: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 23:28: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 23:28: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 23:28: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 23:28:18 INFO - Downloading functools32-3.2.3-2.tar.gz 23:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:28:18 INFO - warning: no files found matching '*.txt' 23:28:18 INFO - no previously-included directories found matching 'build' 23:28:18 INFO - no previously-included directories found matching 'dist' 23:28:18 INFO - no previously-included directories found matching '.git*' 23:28:18 INFO - Installing collected packages: jsonschema, functools32 23:28:18 INFO - Running setup.py install for functools32 23:28:18 INFO - warning: no files found matching '*.txt' 23:28:18 INFO - no previously-included directories found matching 'build' 23:28:18 INFO - no previously-included directories found matching 'dist' 23:28:18 INFO - no previously-included directories found matching '.git*' 23:28:18 INFO - Successfully installed jsonschema functools32 23:28:18 INFO - Cleaning up... 23:28:18 INFO - Return code: 0 23:28:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:28: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')]} 23:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28: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')]} 23:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:28:18 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 0x7f98808b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d160>, '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 0x137e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e4f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', '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 23:28:18 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 23:28:18 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 23:28:18 INFO - Using env: {'DISPLAY': ':0', 23:28:18 INFO - 'HOME': '/home/cltbld', 23:28:18 INFO - 'LANG': 'en_US.UTF-8', 23:28:18 INFO - 'LANGUAGE': 'en_US:en', 23:28:18 INFO - 'LOGNAME': 'cltbld', 23:28:18 INFO - 'MAIL': '/var/mail/cltbld', 23:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:18 INFO - 'MOZ_NO_REMOTE': '1', 23:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:28:18 INFO - 'NO_EM_RESTART': '1', 23:28:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:28:18 INFO - 'PWD': '/builds/slave/test', 23:28:18 INFO - 'SHELL': '/bin/bash', 23:28:18 INFO - 'SHLVL': '1', 23:28:18 INFO - 'TERM': 'linux', 23:28:18 INFO - 'TMOUT': '86400', 23:28:18 INFO - 'USER': 'cltbld', 23:28:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', 23:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:28:18 INFO - '_': '/tools/buildbot/bin/python'} 23:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:28:18 INFO - Downloading/unpacking flake8 23:28:18 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 23:28:18 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 23:28:18 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 23:28:18 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 23:28:18 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 23:28:18 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 23:28:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:28:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:28:20 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 23:28:20 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 23:28:20 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 23:28:20 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 23:28:20 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 23:28:20 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 23:28:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:28:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:28:20 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 23:28:20 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 23:28:20 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 23:28:20 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 23:28:20 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 23:28:20 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 23:28:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:28:20 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 23:28:20 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 23:28:20 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 23:28:20 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 23:28:20 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 23:28:20 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 23:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:28:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:28:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:28:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:28:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:28:21 INFO - no previously-included directories found matching 'docs/_build' 23:28:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:28:21 INFO - Running setup.py install for pep8 23:28:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:28:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:28:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:28:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:28:21 INFO - no previously-included directories found matching 'docs/_build' 23:28:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:28:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:28:21 INFO - Cleaning up... 23:28:21 INFO - Return code: 0 23:28:21 INFO - Running post-action listener: _resource_record_post_action 23:28:21 INFO - Running post-action listener: _start_resource_monitoring 23:28:21 INFO - Starting resource monitoring. 23:28:21 INFO - ##### 23:28:21 INFO - ##### Running install step. 23:28:21 INFO - ##### 23:28:21 INFO - Running pre-action listener: _resource_record_pre_action 23:28:21 INFO - Running main action method: install 23:28:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:28:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:28:21 INFO - Reading from file tmpfile_stdout 23:28:21 INFO - Detecting whether we're running mozinstall >=1.0... 23:28:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:28:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:28:21 INFO - Reading from file tmpfile_stdout 23:28:21 INFO - Output received: 23:28:21 INFO - Usage: mozinstall [options] installer 23:28:21 INFO - Options: 23:28:21 INFO - -h, --help show this help message and exit 23:28:21 INFO - -d DEST, --destination=DEST 23:28:21 INFO - Directory to install application into. [default: 23:28:21 INFO - "/builds/slave/test"] 23:28:21 INFO - --app=APP Application being installed. [default: firefox] 23:28:21 INFO - mkdir: /builds/slave/test/build/application 23:28:21 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'] 23:28:21 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 23:28:34 INFO - Reading from file tmpfile_stdout 23:28:34 INFO - Output received: 23:28:34 INFO - /builds/slave/test/build/application/firefox/firefox 23:28:34 INFO - Running post-action listener: _resource_record_post_action 23:28:34 INFO - ##### 23:28:34 INFO - ##### Running run-tests step. 23:28:34 INFO - ##### 23:28:34 INFO - Running pre-action listener: _resource_record_pre_action 23:28:34 INFO - Running main action method: run_tests 23:28:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:28:34 INFO - Python 2.7.3 23:28:34 INFO - Return code: 0 23:28:34 INFO - grabbing minidump binary from tooltool 23:28:34 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')]} 23:28:34 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 0x137d160>, '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 0x137e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:28:34 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 23:28:34 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 23:28:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:28:34 INFO - Return code: 0 23:28:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:28:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:28:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:28:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:28:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:28:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:28:35 INFO - Return code: 0 23:28:35 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/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 23:28:35 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/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 23:28:35 INFO - Using env: {'DISPLAY': ':0', 23:28:35 INFO - 'HOME': '/home/cltbld', 23:28:35 INFO - 'LANG': 'en_US.UTF-8', 23:28:35 INFO - 'LANGUAGE': 'en_US:en', 23:28:35 INFO - 'LOGNAME': 'cltbld', 23:28:35 INFO - 'MAIL': '/var/mail/cltbld', 23:28:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:28:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:35 INFO - 'MOZ_NO_REMOTE': '1', 23:28:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:28:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:28:35 INFO - 'NO_EM_RESTART': '1', 23:28:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:28:35 INFO - 'PWD': '/builds/slave/test', 23:28:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:28:35 INFO - 'SHELL': '/bin/bash', 23:28:35 INFO - 'SHLVL': '1', 23:28:35 INFO - 'TERM': 'linux', 23:28:35 INFO - 'TMOUT': '86400', 23:28:35 INFO - 'USER': 'cltbld', 23:28:35 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842', 23:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:28:35 INFO - '_': '/tools/buildbot/bin/python'} 23:28:35 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/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 23:28:35 INFO - mozversion application_buildid: 20160425205003 23:28:35 INFO - mozversion application_changeset: 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 23:28:35 INFO - mozversion application_display_name: Firefox 23:28:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:28:35 INFO - mozversion application_name: Firefox 23:28:35 INFO - mozversion application_remotingname: firefox 23:28:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:28:35 INFO - mozversion application_vendor: Mozilla 23:28:35 INFO - mozversion application_version: 47.0 23:28:35 INFO - mozversion platform_buildid: 20160425205003 23:28:35 INFO - mozversion platform_changeset: 5bbf2e7c2fc6ff9010b1948e2f11477f48ee36e2 23:28:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:28:35 INFO - mozversion platform_version: 47.0 23:28:35 INFO - using testdate: 1461652115 23:28:35 INFO - actual date: 1461652115 23:28:35 INFO - starting webserver on 'localhost:44538' 23:28:35 INFO - SUITE-START | Running 2 tests 23:28:35 INFO - TEST-START | dromaeo_css 23:28:35 INFO - operating with platform_type : linux_ 23:28:35 INFO - Initialising browser for dromaeo_css test... 23:28:35 INFO - TEST-INFO | started process 7418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIR6gRb/profile http://localhost:44538/getInfo.html) 23:28:39 INFO - PROCESS | 7418 | 23:28:39 INFO - PROCESS | 7418 | (process:7497): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:28:40 INFO - PROCESS | 7418 | __metrics Screen width/height:1600/1200 23:28:40 INFO - PROCESS | 7418 | colorDepth:24 23:28:40 INFO - PROCESS | 7418 | Browser inner width/height: 1024/697 23:28:40 INFO - PROCESS | 7418 | __metrics 23:28:40 ERROR - PROCESS | 7418 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 23:28:41 INFO - TEST-INFO | 7418: exit 0 23:28:41 INFO - Browser initialized. 23:28:41 INFO - Running cycle 1/1 for dromaeo_css test... 23:28:41 INFO - TEST-INFO | started process 7547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIR6gRb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:28:43 INFO - PROCESS | 7547 | 23:28:43 INFO - PROCESS | 7547 | (process:7613): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:28:53 INFO - PROCESS | 7547 | RSS: Main: 149733376 23:28:53 INFO - PROCESS | 7547 | 23:29:43 INFO - PROCESS | 7547 | 1461652183243 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] 23:31:51 INFO - PROCESS | 7547 | Cycle 1(1): loaded http://localhost:44538/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44538/tests/dromaeo/cssquery-ext.html) 23:31:52 INFO - PROCESS | 7547 | RSS: Main: 153403392 23:31:52 INFO - PROCESS | 7547 | 23:34:53 INFO - PROCESS | 7547 | Cycle 1(1): loaded http://localhost:44538/tests/dromaeo/cssquery-ext.html (next: http://localhost:44538/tests/dromaeo/cssquery-jquery.html) 23:34:54 INFO - PROCESS | 7547 | RSS: Main: 152367104 23:34:54 INFO - PROCESS | 7547 | 23:37:56 INFO - PROCESS | 7547 | Cycle 1(1): loaded http://localhost:44538/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44538/tests/dromaeo/cssquery-mootools.html) 23:37:56 INFO - PROCESS | 7547 | RSS: Main: 151216128 23:37:56 INFO - PROCESS | 7547 | 23:40:58 INFO - PROCESS | 7547 | Cycle 1(1): loaded http://localhost:44538/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44538/tests/dromaeo/cssquery-prototype.html) 23:40:58 INFO - PROCESS | 7547 | RSS: Main: 152313856 23:40:58 INFO - PROCESS | 7547 | 23:44:01 INFO - PROCESS | 7547 | Cycle 1(1): loaded http://localhost:44538/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44538/tests/dromaeo/cssquery-yui.html) 23:44:01 INFO - PROCESS | 7547 | RSS: Main: 150949888 23:44:01 INFO - PROCESS | 7547 | 23:47:03 INFO - PROCESS | 7547 | Cycle 1(1): loaded http://localhost:44538/tests/dromaeo/cssquery-yui.html (next: http://localhost:44538/tests/dromaeo/cssquery-dojo.html) 23:47:04 INFO - PROCESS | 7547 | RSS: Main: 155500544 23:47:04 INFO - PROCESS | 7547 | 23:47:04 INFO - PROCESS | 7547 | __start_tp_report 23:47:04 INFO - PROCESS | 7547 | _x_x_mozilla_page_load 23:47:04 INFO - PROCESS | 7547 | _x_x_mozilla_page_load_details 23:47:04 INFO - PROCESS | 7547 | |i|pagename|runs| 23:47:04 INFO - PROCESS | 7547 | |0;dojo.html;3345.1637090727318;3386.5258863759072;3386.729061675066;3427.5544179256694;3433.2446861690437;5557.72211389431;5567.9977604031255;5571.247881535996;5589.944100558993;5603.3836278009385;5563.666180029191;5598.048331783596;5609.382967873531;5613.719314034292;5616.213730077782;5071.6703414278045;5145.76844042019;5150.098732721777;5182.248573956774;5184.5074717901925;5065.366829146356;5169.896602067956;5200.92198617021;5212.635115541913;5237.6071794615555;5080.0601888650535;5128.615353848458;5168.302279192318;5178.223266510016;5214.478552144793;5156.097682905514;5166.759977605385;5174.66364686296;5180.119379705459;5201.479852014806;4957.603391728653;5036.244563315496;5042.042012017705;5060.3927528696795;5173.9741301293625;5424.294841670597;5434.266374039533;5443.945560544384;5468.699221542814;5475.753591088371;5990;6005.3394126646035;6022.488088512482;6050.21347224858;6062.302835173923;5940.168376427304;6003.7898673546215;6003.879922401571;6007.729652165663;6033.607815492023;5590.888182236414;5595.524380427669;5596.244506991545;5596.916046259309;5610.24261724666;6002.249718785152;6110.3765049759795;6120.112583675431;6120.632762034292;6159.353267906895;6041.607295525777;6065.2418447694035;6077.787277445268;6078.0882867569335;6082.695865206722;6137.140800287963;6154.969225153935;6158.014717645245;6160.876782464416;6161.969190154021;5807.448292412214;5955.374685657944;6009.36901625323;6050.606710563888;6097.481714054266;6040.667763272974;6047.425494578008;6056.424639659225;6058.787942421994;6061;4565.817367305271;4597.471290801601;4601.608863246594;4608;4631.397918270603;4048.2713111640187;4117.629413352813;4121.402396652528;4140.254754144223;4189.560096189917;5585.162225666101;5732.77068917247;5794.942050579524;5803.5357171426185;5834.27071616048;6038.365971572922;6096.664683442365;6097.573169878155;6104.20645316106;6111.327753947062;5573.832785016456;5647.887042259214;5648.85877853057;5735.4551317624755;5762.798302059492;5199.29809475716;5213.817516386908;5218.530332270114;5218.895622087537;5247.107991641354;6198.783042593578;6211.440970312694;6211.81364559064;6228.56400051992;6238.282597501255;5840.795572154954;6014.097885317237;6030.969845150834;6034.064719968412;6035.879282414239;6156.907646385397;6195.628262304096;6207.193064901534;6210.813675589739;6211.9129152399055;5922.318933322723;5950.880982380241;5959.4934430573885;5980.222571065908;5998.730057147526;5830.737616807339;5894.587378883437;5936.079907614327;6010.158577799024;6047.425494578184;5861.267341582302;5878.911816322673;5902.114682797443;5902.498287645598;5910.320313164041;5869.941300586939;5877.206577112035;5889.882202356014;5901.144334071621;5909.734061967308;5681.517071048842;5719.428057194247;5775.537956963517;5776.393478684846;5803.7678492861505;5838.824835254949;5874.794382196603;5882.411758824083;5893.970530147321;5901.822945311647;5657.010023245998;5736.827895163152;5786.247787787561;5791.797287094932;5805.390434004369 23:47:04 INFO - PROCESS | 7547 | |1;ext.html;527.7994362142383;550.7081246939122;572.2360648534207;576.7635269539487;603.1525706382529;38991.41512877309;39694.603053969455;39710.60289397105;39716;39788.80105599475;42335.788321058426;42908.570914290845;43026.99999999992;43073.56926430735;43136.56863431365;8869.423487473327;9015.549222538879;9030.50332231727;9065.22945549629;9085.046070162636;8847.513386763725;9023.368364214508;9043.276537876987;9051.185393314601;9078.727638170833;9223.538823058854;9230.861537076915;9254.491002994866;9303.25573954082;9351.625934962593;9124.543772811367;9282.767930801716;9285.350025498252;9314.673986410444;9320.813583728355;9193.862092068624;9268.304877134175;9310;9322.347435679505;9327.720168394959;44002.33996490055;44860;44904.55095449036;45095.77452112751;45100.54899450996;3772.830222639988;3812.0660438192544;3922.0194951262183;4193.35003074524;4288.270993931039;33384.83307583447;33695.15762105942;33697.66302336994;33745.15637109067;34376.82811585951;4324.978375108104;4345.826166953318;4401;4415.66882483815;4499.887502812423;280734;281134;282451;283008;283246;46866.29700554494;68602;68883;68887;68978.31021689718;46969.5303046972;47120.7643961778;47166.76416617895;47200.05599888052;47208;17629.7355539667;17653.20560574777;17716;17754.467365979042;17778.111094445227;14272.785908211385;14368.353424095942;14375.28123593816;14376.928115359566;14378;15917.363305467652;16031;16096.67806643884;16107.677846443006;16157.030578165348;6140.140380346666;6176.567640265228;6219.284782250009;6222.937770622327;6325.715342809584;1002.0931057393071;1042.3693665332517;1051.264115119404;1108.9243433869135;1116.2242241642143;29334.413311733646;29962.250943726147;30172.698273017428;30554.236144096576;30835;1115.6919732991719;1132.2017977325966;1153.1293873125903;1158.3571118029406;1190.6070996571111;15965.920170399073;16028.839711602968;16077.276522556513;16176.838231617769;16258.75611865823;317746;512245;513617;518960;520645;57697.4230257692;58444.70777646085;58619.70690146522;58797.412025879195;59241.703791480766;1476.402057166849;1502.3314624991992;1507.2614418934643;1520.6502504423822;1562.0705680120311;29836.403271934872;30406.239844004078;30560.235994100327;31351.017398409374;33271;51166.74416627893;52085.47914520958;52217;52619.473805261456;52687.736561316946;245180;246157;248115;248461;249585;35487.290254195286;52181;52268.47731522636;53128;53855.73072134771;49278.50721492739;54511.18233226425;55110.44889551053;56261.718691406284;57026.714866425405;39464;39572.40641390324;39997;40442.39336409897;40963;42077.579224207366;44135.55864441315;44157;44575.33137003012;44676;45162.548374515834;45772.31341529813;46132.077358453316;46398;46666.533334666216;36025;36069.819650901576;36194.45708314325;36858.8157059213;37352.62647373491;28726.425471490034;28946.131616051553;29918.700812991592;31693.207669807518;32096.839515803207 23:47:04 INFO - PROCESS | 7547 | |2;jquery.html;376.90388950817544;385.6760321330083;386.9806509674517;390.74211020726324;396.7084193118056;17597.47207583773;18741.34405295815;19018.2392704292;19270.710939335888;19343.613127737437;17093.658126837487;18160.18279177437;18687.813121868778;18704.532386690338;18765.58759290083;5036.874078148048;5170.146925757245;5198.584113270929;5199.844004679866;5214.973925130369;5208.661437006583;5443.374011988632;5450.236966824647;5469.726513674301;5476.123820188771;5403.567714582824;5431.429699881515;5558.44415558443;6398.616083035009;6407.295197528269;6326;6342.87314253717;6365.108884756138;6369.108324834527;6412.583182093173;5672.234248376458;5689.800856969986;5714.285714285715;5724.169995350692;5731.36954934961;20910.686339704916;21190;21665;22480.775192248195;22489.887550562144;2265.3204038788463;2308.5382923415386;2328.639060945556;2696.1641891013846;2747.32690490829;10037.849432258521;10642.414667193301;11934.98552623028;13354.332283385791;14319.35562899672;2006.8193862552441;2068.586282743457;2078.5842831433624;2088.436122247;2091.790820917896;64287;67705.3229467704;68549.31450685479;68759.31240687579;69262;10000.699979000641;10350.792984140275;10520.316179448311;10549.683509494727;10746.94626526878;14169.362378692984;14264.001519893716;14335.426582936565;14386;14416.567502974927;7862.488938218998;8300.70947516834;8329.50022998622;8392.496450213006;8457.450265732708;8311.958440207882;8373.330133589297;8404.705835295736;8445.437594045121;8451.661933522713;4160.479940007499;4270.35944608305;4472.664550158751;4544.568266014723;4559.635229181657;1859.544411619135;1896.5163883209693;1908.9809101909082;1915.8946257955947;1923.144200830617;975.7414285214423;1035.203921196723;1059.3802625464036;1108.2740804772886;1120.0815331428314;14403.711925761427;15233.466828660943;16134.67730645404;16894.239759210865;18212.998285094447;994.3735446668552;1024.5850430575629;1045.4506948908413;1054.2620165883911;1086.1907878630313;9900.752481188028;9987.350822196535;10086.899131008742;10097.394156350496;10280.331778434527;453641;493694;497411;501601;501764;80690.59654701689;80963.19036809674;81490.59254703688;82913.17086829175;84443.15556844475;1078.1374900079904;1111.1333160135107;1114.921955463126;1128.6783266768932;1133.8752737198902;15998.760018599498;16040.358385664442;16117;16263.430779922646;16436.917815410845;33510.32979340448;33994.15014624654;34567.827160864035;35282.470762938065;36007;44781;47440;47621.76189119032;47836.28245576389;48754.512454876414;8411.90645216118;8459.91540084616;8479.940007499063;8495.235428811437;8574.056853746208;13126.540571079966;13128.409221585243;13314.86685133175;13323.267220302976;13379.799303010657;10121.443320617142;10283.588656453658;11036;11171.38557379352;11708.824367634663;11456.541738330374;11634.011109055826;11749.177557570887;11753.588624398106;11901.226420282654;8449.493030418194;9766.706998790047;11377.601783937522;11510.251833630788;11596.304221746384;8249.917500824915;8382.958085209535;8475.237228649452;8492.02341730709;8511.36164787631;11190.384528850665;11806.527738890349;11827.290362578273;11933.28400295985;12163.81754273669 23:47:04 INFO - PROCESS | 7547 | |3;mootools.html;1606.253092312075;1606.6385063360744;1905.9904700476495;1945.571974165683;2011.446852115669;7774.53352798831;8443.873341899862;8618.525981071038;8925;8927.732168034961;8548.316134709225;8574.442661227016;8674.392792504526;8737.86893196601;8756.562171891395;2465.001674321898;2486.875656217191;2500.3999040230397;2503.2615378463306;2511.748825117492;2399.9880000599974;2488.5147396257735;2492.8628925409093;2499.550080985422;2504.536660717764;2435.2450740270574;2466.2231397109945;2467.284487498623;2479.3305807431984;2484;2485.043258345541;2489.7759201671756;2496.563101457247;2503.224000559814;2531.6708827852353;2479.256223133053;2489.7759201671756;2505.2233807519547;2513.6606558114604;2518.445941892799;8960.417572857743;9001.54992250385;9001.549922503915;9010.954945225232;9016.639334426614;5290.947090529084;5467.043267428184;5469.644473109235;5471.534919531845;5492.725363731797;3349.514320423549;3356.0938546592283;3424.520567120605;3431.1765176357494;3461.913452163691;969.5249327829313;1027.2552399510296;1035.9792804143951;2095.5913596848623;2104.116271166114;12096;12107.39463026845;12191.512339506498;12237.510499580007;12237.755244895141;4391.934120988188;4433.268510695763;4465.12929978651;4506.076254367847;4543.068670922453;9636.084571965652;9783.0706082922;9798.314118011813;9798.657047003464;9835.213182945346;5205.609579281569;5253.238280449314;5254.290670759475;5259.421463638997;5276.129438642581;4751.952480475151;4802.255650374128;4883.706977581285;4894.730789806524;4903.950960490421;3730.3658378075793;3810.7523011004196;3836.0985168485386;3847.61523847613;3871.922561548753;1112.4703532642616;1115.2694984784978;1117.8826223246604;1149.2816989381636;1153.878842721519;1457.5845883923032;1464.0776310924264;1473.8894582906325;1490.8583684549951;1496.0649594003748;8566.657333706706;8619.741407757778;8630.568471576396;8648.913510864937;8661.22049015579;522.5845452864982;524.9448807875118;535.068979974841;569.4021277658442;571.4799532425556;6215.34738852423;6226;6240.095186198067;6283.151774510383;6297.433231009231;10747.193960452842;10979.1765617579;11196.216264861381;11231.550737970552;11244.100471962223;10478.423686697304;10770.138388928866;10797.676069717922;10919.12646988239;10957.616483423042;8469.322454203771;8480.067192608809;8516.06323304436;8534.274586660204;8535.274501667303;8109.1890810920795;8132.75601731949;8134.227248411392;8270.917290827256;8317.916820831715;9574.994625564494;9699.175570076623;9815.901840981498;9995.050470205319;10046.748831279276;9725.416475011521;10041.297109202578;10070.597176112873;10275;10304.484775761332;7956.84086318282;7974;8030.478018928751;8040.718574849852;8054.8791768122355;8531.93350831146;8538.615762290836;8544;8554.27288680469;8563.828723425371;7855.33229675484;7946.086200087064;8001.279884810395;8041.316488098343;8065.1934806518875;7811.921880781119;7818.413618978486;7887.487313324616;7998.48009879356;8015.278624923785;8152.592370381576;8155.959220203861;8204.83590328202;8229;8325.95837020811;7292.817679558054;7295.890561641473;7361.521501102411;7372.299631534996;7388.519746216693;7421.183669796426;7458.47790654649;7478.102627684712;7516.285952834472;7618.69525218985 23:47:04 INFO - PROCESS | 7547 | |4;prototype.html;348.80815551446705;351.7590450541379;357.29434367124946;358.06366351989556;358.14939518643223;6375.298717141122;6384.776532821346;6393.36066393361;6413.166288382516;6420.3579642035775;6334.556581039329;6349.269833969095;6349.936500634993;6362.204724409449;6380.04299355097;4709.128811169944;4809.086273608021;4905.901881962359;4917.852464426055;4925.138100832358;4864.927026094611;4905.215165573509;4908.0429316283335;4924.384451943507;4955.826546070888;4869.659123861331;4907.509249075082;4912.508749125077;4915.139850526161;4918.286848406979;4900.950990490085;4913.508649135076;4921.606271498272;4925.31045653607;4940.728259945701;4331.306990881444;4337.219300525904;4341.9348709769065;4346.174226896879;4356.803943822536;5911.9113213301835;5984.281886173643;6040.395960403968;6043.758249670052;6045.879082418371;5743.9425605744245;5776.537876969833;5786.045302525078;5787.6399046224105;5792.710364481801;6761.695723692396;6771.153605799275;6775.525713200078;6775.593464392152;6778.593284402951;4825.4933232010835;4827.975860120712;4832.879178020543;4835.516448355172;4837.588804951583;7050.29497050296;7072.15134183896;7077.646117694147;7081.044059052014;7084.220735719066;4643.721376717408;4824.541668541553;4826.662133650681;4830.3479030331155;4970.130227210224;4871.48849370811;4891.413030436299;4900.558949694473;4902.362692849907;4904.632152588499;5630.915536266959;5641.323041235078;5673.858153546194;5675.3757086720425;5680.460356266148;6839.965800170968;6845.760398386033;6847.246802851682;6850.212225594021;6852.211995620568;1704.4204970309906;1739.6346767178782;1749.2915369275463;1752.6845167869906;1753.9561510962328;1047.2878442658912;1077.8113830079706;1084.6366467233408;1101.4437708956925;1107.0811226681835;6495.415412612888;6519.4132528072705;6523.641199733966;6525.11910892033;6535.705893234815;6940.7917762467205;6968.965155174192;6974.79075627732;6983.162020557464;6989.091418115612;6526.738930442729;6572.14562106923;6578.901316480256;6587.50593705474;6587.9670601646685;3803;3844.461775351453;3847.3267178243696;3854.3640299350855;3854.845806167778;7310.1593316768185;7311.4516411268305;7321.352695643438;7325.377342925911;7328.96335518319;7061.470389720792;7235.493515453868;7270.563766174047;7299.124105107421;7299.781006569811;7336.706531738778;7374.410047196318;7396.667149978264;7405.074365704287;7420.703171873172;7096.680649370894;7107.573545587281;7121.893171602326;7122.643867806485;7137.179224389054;6983.44132469391;7015.333543313377;7025.859482810213;7044.330788575077;7052.894206586802;7226.277372262732;7375.483716140034;7383.778486645409;7391.2978267064545;7408.296211859864;4823.710577365369;4849.3210950467665;4867.853964381075;4880.731559764247;4881.51184881509;7109.253528379652;7116.537425067354;7116.786496405116;7124.180719217149;7128.429725622042;6866.793996180123;6880.311968803079;6885.139357580302;6889.655517224219;6890.44876409896;6752.088468056946;6881.931180688129;6881.965590172217;6889.862202756017;6892.276930767308;6720.1263835703;6761.121054262914;6761.594304341756;6765.932340676531;6781.457483401217;6859.348361905611;6892.620905850226;6920.965395173193;6921.307869213038;6925;6661.866762664817;6695.7321707133115;6696.1629796275465;6696.363845434676;6728.428083612947 23:47:04 INFO - PROCESS | 7547 | |5;yui.html;810.9229623185796;830.8936845097678;864.2394692670453;927.3230541704552;931.594756281018;14341;14480.855191448083;14621.268936553157;14671.486497972573;14705.55883323502;13787.931060344685;13801.240931748749;13844.792328115087;13888.652783680413;13894.583162505141;895.9776005599863;930.6370515498961;956.3496822160928;956.3879117364858;959.7216807125925;934.2432629570036;938.2962777916563;942.2603256443693;946.3801210207325;947.5877993073001;974.5663179884954;991.7322322972793;994.3188915592806;995.1789773436907;995.9302848800587;972.363102168081;974.3812678948883;975.878015248094;980.5440470181329;980.6028558433845;726.5640615630632;729.1323325242944;729.1396152540001;731.0678884422404;731.7438896386222;14579.635509112251;14606.780898286534;14622.634434139125;14678.559643210721;14692.926535367362;13756.518521851687;13837.169769813843;13863.861361386358;13921.930390347983;13997.3701183447;11650.126240531994;11714.121440891968;11714.53141874324;11881.524739010429;11977;3864.8647297344737;3870.283997460479;3886.747361421527;3923.843046278174;3962.445257663929;50067.74966125146;50375.24437133446;50475.495245047445;51046;51393.486065139616;10908.945455272673;10984.340939543654;11013.394263315435;11060.944695276472;11118;17483.56291092733;17611.207495662726;17612;17637.382691605733;19579.216831326587;8486.278666313308;8560.0583935767;8638.09300023501;8676.78308042304;8678.349123815738;4804.975975120172;4905.509449055137;5007.4491805901325;5008.924866127011;5123.897522049613;3465.8440370183403;3465.9480107798404;3467.7745946513396;3486.1981744198974;3504.1940353718787;645.0710976194265;650.4211251985737;654.9803505894831;657.044000978575;659.1891972873393;610.4719417703743;690.7168061094927;716.7921302822227;730.9246493938724;751.7970148059993;8696.78258043554;8863.64545418189;8976.8653470198;9053.502057386908;9181.35730498872;575.3728436004691;617.5183356981562;666.7999600119945;698.7798843364324;700.7617410080597;4105.445764821711;4277.251480990814;4350.499692535335;4393.450818647669;4428.579284967923;55409.44590554124;55703;55772.72113639406;56262.156067659016;56426.43573564294;49495;50444.74777626088;50887.7455612727;51355;51357;47028.76485617618;47067;47238.763806181436;47554.76222618934;47827.52172478231;8207.425480216567;8291.83416331682;8414.453060551044;8505.95747021261;8693.304535637008;34874.47688284729;35563;36819.26361472702;36894.63105368912;37018.25963480769;39552.40671389874;40476.1904761909;44380;45526.089478209586;45853;10336.224783141444;10579.841302380624;10584.947075264574;10616.787664246825;10692.411917344622;11540.076793856639;11585.402392984732;11668.299902005567;11698.883011169779;11722.413879306172;11087.778244434905;11305.7738845221;11630.70923226926;11684.065274778168;12052.75894482123;11163.548738663922;11193.72015699614;11289;11366.659000230007;11623.6512904613;11516.366599837089;12488.25070495773;12720.6819829505;12853.614391568268;13238.735225295633;10655.25413221067;10784.245102842726;10788.784224315314;10999.560017599206;11080.279781814157;10377.377357358582;10522.421266830092;10534.683959481228;10538.525766340379;10662.253642244968 23:47:04 INFO - PROCESS | 7547 | __end_tp_report 23:47:04 INFO - PROCESS | 7547 | __start_cc_report 23:47:04 INFO - PROCESS | 7547 | _x_x_mozilla_cycle_collect,331 23:47:04 INFO - PROCESS | 7547 | __end_cc_report 23:47:04 INFO - PROCESS | 7547 | __startTimestamp1461653224173__endTimestamp 23:47:04 INFO - PROCESS | 7547 | 23:47:04 INFO - PROCESS | 7547 | ------- Summary: start ------- 23:47:04 INFO - PROCESS | 7547 | Number of tests: 6 23:47:04 INFO - PROCESS | 7547 | 23:47:04 INFO - PROCESS | 7547 | [#0] dojo.html Cycles:165 Average:5595.49 Median:5803.77 stddev:617.40 (10.6%) stddev-sans-first:593.52 23:47:04 INFO - PROCESS | 7547 | Values: 3345.2 3386.5 3386.7 3427.6 3433.2 5557.7 5568.0 5571.2 5589.9 5603.4 5563.7 5598.0 5609.4 5613.7 5616.2 5071.7 5145.8 5150.1 5182.2 5184.5 5065.4 5169.9 5200.9 5212.6 5237.6 5080.1 5128.6 5168.3 5178.2 5214.5 5156.1 5166.8 5174.7 5180.1 5201.5 4957.6 5036.2 5042.0 5060.4 5174.0 5424.3 5434.3 5443.9 5468.7 5475.8 5990.0 6005.3 6022.5 6050.2 6062.3 5940.2 6003.8 6003.9 6007.7 6033.6 5590.9 5595.5 5596.2 5596.9 5610.2 6002.2 6110.4 6120.1 6120.6 6159.4 6041.6 6065.2 6077.8 6078.1 6082.7 6137.1 6155.0 6158.0 6160.9 6162.0 5807.4 5955.4 6009.4 6050.6 6097.5 6040.7 6047.4 6056.4 6058.8 6061.0 4565.8 4597.5 4601.6 4608.0 4631.4 4048.3 4117.6 4121.4 4140.3 4189.6 5585.2 5732.8 5794.9 5803.5 5834.3 6038.4 6096.7 6097.6 6104.2 6111.3 5573.8 5647.9 5648.9 5735.5 5762.8 5199.3 5213.8 5218.5 5218.9 5247.1 6198.8 6211.4 6211.8 6228.6 6238.3 5840.8 6014.1 6031.0 6034.1 6035.9 6156.9 6195.6 6207.2 6210.8 6211.9 5922.3 5950.9 5959.5 5980.2 5998.7 5830.7 5894.6 5936.1 6010.2 6047.4 5861.3 5878.9 5902.1 5902.5 5910.3 5869.9 5877.2 5889.9 5901.1 5909.7 5681.5 5719.4 5775.5 5776.4 5803.8 5838.8 5874.8 5882.4 5894.0 5901.8 5657.0 5736.8 5786.2 5791.8 5805.4 23:47:04 INFO - PROCESS | 7547 | 23:47:04 INFO - PROCESS | 7547 | [#1] ext.html Cycles:180 Average:52235.17 Median:43050.28 stddev:93364.89 (216.9%) stddev-sans-first:93546.08 23:47:04 INFO - PROCESS | 7547 | Values: 527.8 550.7 572.2 576.8 603.2 38991.4 39694.6 39710.6 39716.0 39788.8 42335.8 42908.6 43027.0 43073.6 43136.6 8869.4 9015.5 9030.5 9065.2 9085.0 8847.5 9023.4 9043.3 9051.2 9078.7 9223.5 9230.9 9254.5 9303.3 9351.6 9124.5 9282.8 9285.4 9314.7 9320.8 9193.9 9268.3 9310.0 9322.3 9327.7 44002.3 44860.0 44904.6 45095.8 45100.5 3772.8 3812.1 3922.0 4193.4 4288.3 33384.8 33695.2 33697.7 33745.2 34376.8 4325.0 4345.8 4401.0 4415.7 4499.9 280734.0 281134.0 282451.0 283008.0 283246.0 46866.3 68602.0 68883.0 68887.0 68978.3 46969.5 47120.8 47166.8 47200.1 47208.0 17629.7 17653.2 17716.0 17754.5 17778.1 14272.8 14368.4 14375.3 14376.9 14378.0 15917.4 16031.0 16096.7 16107.7 16157.0 6140.1 6176.6 6219.3 6222.9 6325.7 1002.1 1042.4 1051.3 1108.9 1116.2 29334.4 29962.3 30172.7 30554.2 30835.0 1115.7 1132.2 1153.1 1158.4 1190.6 15965.9 16028.8 16077.3 16176.8 16258.8 317746.0 512245.0 513617.0 518960.0 520645.0 57697.4 58444.7 58619.7 58797.4 59241.7 1476.4 1502.3 1507.3 1520.7 1562.1 29836.4 30406.2 30560.2 31351.0 33271.0 51166.7 52085.5 52217.0 52619.5 52687.7 245180.0 246157.0 248115.0 248461.0 249585.0 35487.3 52181.0 52268.5 53128.0 53855.7 49278.5 54511.2 55110.4 56261.7 57026.7 39464.0 39572.4 39997.0 40442.4 40963.0 42077.6 44135.6 44157.0 44575.3 44676.0 45162.5 45772.3 46132.1 46398.0 46666.5 36025.0 36069.8 36194.5 36858.8 37352.6 28726.4 28946.1 29918.7 31693.2 32096.8 23:47:04 INFO - PROCESS | 7547 | 23:47:04 INFO - PROCESS | 7547 | [#2] jquery.html Cycles:180 Average:27613.30 Median:2318.59 stddev:80292.52 (3463.0%) stddev-sans-first:80491.71 23:47:04 INFO - PROCESS | 7547 | Values: 376.9 385.7 387.0 390.7 396.7 17597.5 18741.3 19018.2 19270.7 19343.6 17093.7 18160.2 18687.8 18704.5 18765.6 5036.9 5170.1 5198.6 5199.8 5215.0 5208.7 5443.4 5450.2 5469.7 5476.1 5403.6 5431.4 5558.4 6398.6 6407.3 6326.0 6342.9 6365.1 6369.1 6412.6 5672.2 5689.8 5714.3 5724.2 5731.4 20910.7 21190.0 21665.0 22480.8 22489.9 2265.3 2308.5 2328.6 2696.2 2747.3 10037.8 10642.4 11935.0 13354.3 14319.4 2006.8 2068.6 2078.6 2088.4 2091.8 64287.0 67705.3 68549.3 68759.3 69262.0 10000.7 10350.8 10520.3 10549.7 10746.9 14169.4 14264.0 14335.4 14386.0 14416.6 7862.5 8300.7 8329.5 8392.5 8457.5 8312.0 8373.3 8404.7 8445.4 8451.7 4160.5 4270.4 4472.7 4544.6 4559.6 1859.5 1896.5 1909.0 1915.9 1923.1 975.7 1035.2 1059.4 1108.3 1120.1 14403.7 15233.5 16134.7 16894.2 18213.0 994.4 1024.6 1045.5 1054.3 1086.2 9900.8 9987.4 10086.9 10097.4 10280.3 453641.0 493694.0 497411.0 501601.0 501764.0 80690.6 80963.2 81490.6 82913.2 84443.2 1078.1 1111.1 1114.9 1128.7 1133.9 15998.8 16040.4 16117.0 16263.4 16436.9 33510.3 33994.2 34567.8 35282.5 36007.0 44781.0 47440.0 47621.8 47836.3 48754.5 8411.9 8459.9 8479.9 8495.2 8574.1 13126.5 13128.4 13314.9 13323.3 13379.8 10121.4 10283.6 11036.0 11171.4 11708.8 11456.5 11634.0 11749.2 11753.6 11901.2 8449.5 9766.7 11377.6 11510.3 11596.3 8249.9 8383.0 8475.2 8492.0 8511.4 11190.4 11806.5 11827.3 11933.3 12163.8 23:47:04 INFO - PROCESS | 7547 | 23:47:04 INFO - PROCESS | 7547 | [#3] mootools.html Cycles:180 Average:6196.40 Median:5283.54 stddev:3297.02 (62.4%) stddev-sans-first:3288.22 23:47:04 INFO - PROCESS | 7547 | Values: 1606.3 1606.6 1906.0 1945.6 2011.4 7774.5 8443.9 8618.5 8925.0 8927.7 8548.3 8574.4 8674.4 8737.9 8756.6 2465.0 2486.9 2500.4 2503.3 2511.7 2400.0 2488.5 2492.9 2499.6 2504.5 2435.2 2466.2 2467.3 2479.3 2484.0 2485.0 2489.8 2496.6 2503.2 2531.7 2479.3 2489.8 2505.2 2513.7 2518.4 8960.4 9001.5 9001.5 9011.0 9016.6 5290.9 5467.0 5469.6 5471.5 5492.7 3349.5 3356.1 3424.5 3431.2 3461.9 969.5 1027.3 1036.0 2095.6 2104.1 12096.0 12107.4 12191.5 12237.5 12237.8 4391.9 4433.3 4465.1 4506.1 4543.1 9636.1 9783.1 9798.3 9798.7 9835.2 5205.6 5253.2 5254.3 5259.4 5276.1 4752.0 4802.3 4883.7 4894.7 4904.0 3730.4 3810.8 3836.1 3847.6 3871.9 1112.5 1115.3 1117.9 1149.3 1153.9 1457.6 1464.1 1473.9 1490.9 1496.1 8566.7 8619.7 8630.6 8648.9 8661.2 522.6 524.9 535.1 569.4 571.5 6215.3 6226.0 6240.1 6283.2 6297.4 10747.2 10979.2 11196.2 11231.6 11244.1 10478.4 10770.1 10797.7 10919.1 10957.6 8469.3 8480.1 8516.1 8534.3 8535.3 8109.2 8132.8 8134.2 8270.9 8317.9 9575.0 9699.2 9815.9 9995.1 10046.7 9725.4 10041.3 10070.6 10275.0 10304.5 7956.8 7974.0 8030.5 8040.7 8054.9 8531.9 8538.6 8544.0 8554.3 8563.8 7855.3 7946.1 8001.3 8041.3 8065.2 7811.9 7818.4 7887.5 7998.5 8015.3 8152.6 8156.0 8204.8 8229.0 8326.0 7292.8 7295.9 7361.5 7372.3 7388.5 7421.2 7458.5 7478.1 7516.3 7618.7 23:47:04 INFO - PROCESS | 7547 | 23:47:04 INFO - PROCESS | 7547 | [#4] prototype.html Cycles:180 Average:5721.24 Median:6507.41 stddev:1732.14 (26.6%) stddev-sans-first:1689.41 23:47:04 INFO - PROCESS | 7547 | Values: 348.8 351.8 357.3 358.1 358.1 6375.3 6384.8 6393.4 6413.2 6420.4 6334.6 6349.3 6349.9 6362.2 6380.0 4709.1 4809.1 4905.9 4917.9 4925.1 4864.9 4905.2 4908.0 4924.4 4955.8 4869.7 4907.5 4912.5 4915.1 4918.3 4901.0 4913.5 4921.6 4925.3 4940.7 4331.3 4337.2 4341.9 4346.2 4356.8 5911.9 5984.3 6040.4 6043.8 6045.9 5743.9 5776.5 5786.0 5787.6 5792.7 6761.7 6771.2 6775.5 6775.6 6778.6 4825.5 4828.0 4832.9 4835.5 4837.6 7050.3 7072.2 7077.6 7081.0 7084.2 4643.7 4824.5 4826.7 4830.3 4970.1 4871.5 4891.4 4900.6 4902.4 4904.6 5630.9 5641.3 5673.9 5675.4 5680.5 6840.0 6845.8 6847.2 6850.2 6852.2 1704.4 1739.6 1749.3 1752.7 1754.0 1047.3 1077.8 1084.6 1101.4 1107.1 6495.4 6519.4 6523.6 6525.1 6535.7 6940.8 6969.0 6974.8 6983.2 6989.1 6526.7 6572.1 6578.9 6587.5 6588.0 3803.0 3844.5 3847.3 3854.4 3854.8 7310.2 7311.5 7321.4 7325.4 7329.0 7061.5 7235.5 7270.6 7299.1 7299.8 7336.7 7374.4 7396.7 7405.1 7420.7 7096.7 7107.6 7121.9 7122.6 7137.2 6983.4 7015.3 7025.9 7044.3 7052.9 7226.3 7375.5 7383.8 7391.3 7408.3 4823.7 4849.3 4867.9 4880.7 4881.5 7109.3 7116.5 7116.8 7124.2 7128.4 6866.8 6880.3 6885.1 6889.7 6890.4 6752.1 6881.9 6882.0 6889.9 6892.3 6720.1 6761.1 6761.6 6765.9 6781.5 6859.3 6892.6 6921.0 6921.3 6925.0 6661.9 6695.7 6696.2 6696.4 6728.4 23:47:04 INFO - PROCESS | 7547 | 23:47:04 INFO - PROCESS | 7547 | [#5] yui.html Cycles:180 Average:14191.01 Median:4411.02 stddev:15885.61 (360.1%) stddev-sans-first:15898.39 23:47:04 INFO - PROCESS | 7547 | Values: 810.9 830.9 864.2 927.3 931.6 14341.0 14480.9 14621.3 14671.5 14705.6 13787.9 13801.2 13844.8 13888.7 13894.6 896.0 930.6 956.3 956.4 959.7 934.2 938.3 942.3 946.4 947.6 974.6 991.7 994.3 995.2 995.9 972.4 974.4 975.9 980.5 980.6 726.6 729.1 729.1 731.1 731.7 14579.6 14606.8 14622.6 14678.6 14692.9 13756.5 13837.2 13863.9 13921.9 13997.4 11650.1 11714.1 11714.5 11881.5 11977.0 3864.9 3870.3 3886.7 3923.8 3962.4 50067.7 50375.2 50475.5 51046.0 51393.5 10908.9 10984.3 11013.4 11060.9 11118.0 17483.6 17611.2 17612.0 17637.4 19579.2 8486.3 8560.1 8638.1 8676.8 8678.3 4805.0 4905.5 5007.4 5008.9 5123.9 3465.8 3465.9 3467.8 3486.2 3504.2 645.1 650.4 655.0 657.0 659.2 610.5 690.7 716.8 730.9 751.8 8696.8 8863.6 8976.9 9053.5 9181.4 575.4 617.5 666.8 698.8 700.8 4105.4 4277.3 4350.5 4393.5 4428.6 55409.4 55703.0 55772.7 56262.2 56426.4 49495.0 50444.7 50887.7 51355.0 51357.0 47028.8 47067.0 47238.8 47554.8 47827.5 8207.4 8291.8 8414.5 8506.0 8693.3 34874.5 35563.0 36819.3 36894.6 37018.3 39552.4 40476.2 44380.0 45526.1 45853.0 10336.2 10579.8 10584.9 10616.8 10692.4 11540.1 11585.4 11668.3 11698.9 11722.4 11087.8 11305.8 11630.7 11684.1 12052.8 11163.5 11193.7 11289.0 11366.7 11623.7 11516.4 12488.3 12720.7 12853.6 13238.7 10655.3 10784.2 10788.8 10999.6 11080.3 10377.4 10522.4 10534.7 10538.5 10662.3 23:47:04 INFO - PROCESS | 7547 | -------- Summary: end -------- 23:47:04 INFO - PROCESS | 7547 | 23:47:04 INFO - TEST-INFO | 7547: exit 0 23:47:04 INFO - TEST-OK | dromaeo_css | took 1109129ms 23:47:04 INFO - TEST-START | kraken 23:47:04 INFO - operating with platform_type : linux_ 23:47:04 INFO - Initialising browser for kraken test... 23:47:04 INFO - TEST-INFO | started process 7790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF9aHTY/profile http://localhost:44538/getInfo.html) 23:47:08 INFO - PROCESS | 7790 | 23:47:08 INFO - PROCESS | 7790 | (process:7865): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:47:09 INFO - PROCESS | 7790 | __metrics Screen width/height:1600/1200 23:47:09 INFO - PROCESS | 7790 | colorDepth:24 23:47:09 INFO - PROCESS | 7790 | Browser inner width/height: 1024/697 23:47:09 INFO - PROCESS | 7790 | __metrics 23:47:09 ERROR - PROCESS | 7790 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 23:47:10 INFO - TEST-INFO | 7790: exit 0 23:47:10 INFO - Browser initialized. 23:47:10 INFO - Running cycle 1/1 for kraken test... 23:47:10 INFO - TEST-INFO | started process 7915 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF9aHTY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:47:12 INFO - PROCESS | 7915 | 23:47:12 INFO - PROCESS | 7915 | (process:7982): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:47:22 INFO - PROCESS | 7915 | RSS: Main: 149778432 23:47:22 INFO - PROCESS | 7915 | 23:47:24 INFO - PROCESS | 7915 | Cycle 1(1): loaded http://localhost:44538/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44538/tests/kraken/driver.html?testName=audio-beat-detection) 23:47:25 INFO - PROCESS | 7915 | RSS: Main: 153993216 23:47:25 INFO - PROCESS | 7915 | 23:47:28 INFO - PROCESS | 7915 | Cycle 1(1): loaded http://localhost:44538/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44538/tests/kraken/driver.html?testName=audio-dft) 23:47:28 INFO - PROCESS | 7915 | RSS: Main: 154042368 23:47:28 INFO - PROCESS | 7915 | 23:47:31 INFO - PROCESS | 7915 | Cycle 1(1): loaded http://localhost:44538/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44538/tests/kraken/driver.html?testName=audio-fft) 23:47:32 INFO - PROCESS | 7915 | RSS: Main: 154402816 23:47:32 INFO - PROCESS | 7915 | 23:47:34 INFO - PROCESS | 7915 | Cycle 1(1): loaded http://localhost:44538/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44538/tests/kraken/driver.html?testName=audio-oscillator) 23:47:34 INFO - PROCESS | 7915 | RSS: Main: 154406912 23:47:34 INFO - PROCESS | 7915 | 23:47:37 INFO - PROCESS | 7915 | Cycle 1(1): loaded http://localhost:44538/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44538/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:47:37 INFO - PROCESS | 7915 | RSS: Main: 154365952 23:47:37 INFO - PROCESS | 7915 | 23:47:40 INFO - PROCESS | 7915 | Cycle 1(1): loaded http://localhost:44538/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44538/tests/kraken/driver.html?testName=imaging-darkroom) 23:47:41 INFO - PROCESS | 7915 | RSS: Main: 154550272 23:47:41 INFO - PROCESS | 7915 | 23:47:44 INFO - PROCESS | 7915 | Cycle 1(1): loaded http://localhost:44538/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44538/tests/kraken/driver.html?testName=imaging-desaturate) 23:47:45 INFO - PROCESS | 7915 | RSS: Main: 154673152 23:47:45 INFO - PROCESS | 7915 | 23:47:48 INFO - PROCESS | 7915 | Cycle 1(1): loaded http://localhost:44538/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44538/tests/kraken/driver.html?testName=json-parse-financial) 23:47:48 INFO - PROCESS | 7915 | RSS: Main: 154804224 23:47:48 INFO - PROCESS | 7915 | 23:47:50 INFO - PROCESS | 7915 | Cycle 1(1): loaded http://localhost:44538/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44538/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:47:50 INFO - PROCESS | 7915 | RSS: Main: 154796032 23:47:50 INFO - PROCESS | 7915 | 23:47:52 INFO - PROCESS | 7915 | Cycle 1(1): loaded http://localhost:44538/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44538/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:47:53 INFO - PROCESS | 7915 | RSS: Main: 154939392 23:47:53 INFO - PROCESS | 7915 | 23:47:55 INFO - PROCESS | 7915 | Cycle 1(1): loaded http://localhost:44538/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44538/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:47:55 INFO - PROCESS | 7915 | RSS: Main: 155242496 23:47:55 INFO - PROCESS | 7915 | 23:47:58 INFO - PROCESS | 7915 | Cycle 1(1): loaded http://localhost:44538/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44538/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:47:58 INFO - PROCESS | 7915 | RSS: Main: 155385856 23:47:58 INFO - PROCESS | 7915 | 23:48:01 INFO - PROCESS | 7915 | Cycle 1(1): loaded http://localhost:44538/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44538/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:48:02 INFO - PROCESS | 7915 | RSS: Main: 155185152 23:48:02 INFO - PROCESS | 7915 | 23:48:03 INFO - PROCESS | 7915 | Cycle 1(1): loaded http://localhost:44538/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44538/tests/kraken/driver.html?testName=ai-astar) 23:48:03 INFO - PROCESS | 7915 | RSS: Main: 156868608 23:48:03 INFO - PROCESS | 7915 | 23:48:03 INFO - PROCESS | 7915 | __start_tp_report 23:48:03 INFO - PROCESS | 7915 | _x_x_mozilla_page_load 23:48:03 INFO - PROCESS | 7915 | _x_x_mozilla_page_load_details 23:48:03 INFO - PROCESS | 7915 | |i|pagename|runs| 23:48:03 INFO - PROCESS | 7915 | |0;ai-astar;111;104;112;112;113;121;111;109;111;112 23:48:03 INFO - PROCESS | 7915 | |1;audio-beat-detection;155;127;155;165;128;156;159;137;184;128 23:48:03 INFO - PROCESS | 7915 | |2;audio-dft;162;163;161;171;163;163;162;164;166;163 23:48:03 INFO - PROCESS | 7915 | |3;audio-fft;76;76;76;168;74;76;76;77;159;78 23:48:03 INFO - PROCESS | 7915 | |4;audio-oscillator;94;94;147;95;94;93;144;93;93;150 23:48:03 INFO - PROCESS | 7915 | |5;imaging-gaussian-blur;117;117;117;118;118;117;117;117;117;118 23:48:03 INFO - PROCESS | 7915 | |6;imaging-darkroom;146;146;147;148;146;145;146;147;146;148 23:48:03 INFO - PROCESS | 7915 | |7;imaging-desaturate;97;96;98;95;97;96;96;95;96;95 23:48:03 INFO - PROCESS | 7915 | |8;json-parse-financial;59;58;58;60;58;57;57;67;56;57 23:48:03 INFO - PROCESS | 7915 | |9;json-stringify-tinderbox;71;71;72;72;74;73;72;73;73;72 23:48:03 INFO - PROCESS | 7915 | |10;stanford-crypto-aes;77;79;80;78;78;80;80;83;80;78 23:48:03 INFO - PROCESS | 7915 | |11;stanford-crypto-ccm;115;129;119;114;115;116;117;115;123;115 23:48:03 INFO - PROCESS | 7915 | |12;stanford-crypto-pbkdf2;137;149;151;151;153;146;155;145;146;136 23:48:03 INFO - PROCESS | 7915 | |13;stanford-crypto-sha256-iterative;71;68;70;68;74;67;67;71;67;71 23:48:03 INFO - PROCESS | 7915 | __end_tp_report 23:48:03 INFO - PROCESS | 7915 | __start_cc_report 23:48:03 INFO - PROCESS | 7915 | _x_x_mozilla_cycle_collect,818 23:48:03 INFO - PROCESS | 7915 | __end_cc_report 23:48:03 INFO - PROCESS | 7915 | __startTimestamp1461653283971__endTimestamp 23:48:03 INFO - PROCESS | 7915 | 23:48:03 INFO - PROCESS | 7915 | ------- Summary: start ------- 23:48:03 INFO - PROCESS | 7915 | Number of tests: 14 23:48:03 INFO - PROCESS | 7915 | 23:48:03 INFO - PROCESS | 7915 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:4.17 (3.7%) stddev-sans-first:4.42 23:48:03 INFO - PROCESS | 7915 | Values: 111.0 104.0 112.0 112.0 113.0 121.0 111.0 109.0 111.0 112.0 23:48:03 INFO - PROCESS | 7915 | 23:48:03 INFO - PROCESS | 7915 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:155.50 stddev:18.89 (12.1%) stddev-sans-first:19.92 23:48:03 INFO - PROCESS | 7915 | Values: 155.0 127.0 155.0 165.0 128.0 156.0 159.0 137.0 184.0 128.0 23:48:03 INFO - PROCESS | 7915 | 23:48:03 INFO - PROCESS | 7915 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:2.86 (1.8%) stddev-sans-first:2.96 23:48:03 INFO - PROCESS | 7915 | Values: 162.0 163.0 161.0 171.0 163.0 163.0 162.0 164.0 166.0 163.0 23:48:03 INFO - PROCESS | 7915 | 23:48:03 INFO - PROCESS | 7915 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:36.91 (48.6%) stddev-sans-first:38.60 23:48:03 INFO - PROCESS | 7915 | Values: 76.0 76.0 76.0 168.0 74.0 76.0 76.0 77.0 159.0 78.0 23:48:03 INFO - PROCESS | 7915 | 23:48:03 INFO - PROCESS | 7915 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:93.50 stddev:25.79 (27.6%) stddev-sans-first:26.72 23:48:03 INFO - PROCESS | 7915 | Values: 94.0 94.0 147.0 95.0 94.0 93.0 144.0 93.0 93.0 150.0 23:48:03 INFO - PROCESS | 7915 | 23:48:03 INFO - PROCESS | 7915 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 23:48:03 INFO - PROCESS | 7915 | Values: 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 23:48:03 INFO - PROCESS | 7915 | 23:48:03 INFO - PROCESS | 7915 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 23:48:03 INFO - PROCESS | 7915 | Values: 146.0 146.0 147.0 148.0 146.0 145.0 146.0 147.0 146.0 148.0 23:48:03 INFO - PROCESS | 7915 | 23:48:03 INFO - PROCESS | 7915 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:1.00 23:48:03 INFO - PROCESS | 7915 | Values: 97.0 96.0 98.0 95.0 97.0 96.0 96.0 95.0 96.0 95.0 23:48:03 INFO - PROCESS | 7915 | 23:48:03 INFO - PROCESS | 7915 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:58.00 stddev:3.13 (5.4%) stddev-sans-first:3.32 23:48:03 INFO - PROCESS | 7915 | Values: 59.0 58.0 58.0 60.0 58.0 57.0 57.0 67.0 56.0 57.0 23:48:03 INFO - PROCESS | 7915 | 23:48:03 INFO - PROCESS | 7915 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:72.50 stddev:0.95 (1.3%) stddev-sans-first:0.88 23:48:03 INFO - PROCESS | 7915 | Values: 71.0 71.0 72.0 72.0 74.0 73.0 72.0 73.0 73.0 72.0 23:48:03 INFO - PROCESS | 7915 | 23:48:03 INFO - PROCESS | 7915 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:80.00 stddev:1.70 (2.1%) stddev-sans-first:1.59 23:48:03 INFO - PROCESS | 7915 | Values: 77.0 79.0 80.0 78.0 78.0 80.0 80.0 83.0 80.0 78.0 23:48:03 INFO - PROCESS | 7915 | 23:48:03 INFO - PROCESS | 7915 | [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:116.50 stddev:4.76 (4.1%) stddev-sans-first:4.94 23:48:03 INFO - PROCESS | 7915 | Values: 115.0 129.0 119.0 114.0 115.0 116.0 117.0 115.0 123.0 115.0 23:48:03 INFO - PROCESS | 7915 | 23:48:03 INFO - PROCESS | 7915 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.90 Median:150.00 stddev:6.35 (4.2%) stddev-sans-first:5.63 23:48:03 INFO - PROCESS | 7915 | Values: 137.0 149.0 151.0 151.0 153.0 146.0 155.0 145.0 146.0 136.0 23:48:03 INFO - PROCESS | 7915 | 23:48:03 INFO - PROCESS | 7915 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.50 stddev:2.37 (3.4%) stddev-sans-first:2.44 23:48:03 INFO - PROCESS | 7915 | Values: 71.0 68.0 70.0 68.0 74.0 67.0 67.0 71.0 67.0 71.0 23:48:03 INFO - PROCESS | 7915 | -------- Summary: end -------- 23:48:03 INFO - PROCESS | 7915 | 23:48:04 INFO - TEST-INFO | 7915: exit 0 23:48:04 INFO - TEST-OK | kraken | took 60001ms 23:48:04 INFO - SUITE-END | took 1169s 23:48:05 INFO - Completed test suite (00:19:29) 23:48:05 INFO - javascript benchmark 23:48:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3345.1637090727318, 3386.5258863759072, 3386.729061675066, 3427.5544179256694, 3433.2446861690437, 5557.72211389431, 5567.9977604031255, 5571.247881535996, 5589.944100558993, 5603.3836278009385, 5563.666180029191, 5598.048331783596, 5609.382967873531, 5613.719314034292, 5616.213730077782, 5071.6703414278045, 5145.76844042019, 5150.098732721777, 5182.248573956774, 5184.5074717901925, 5065.366829146356, 5169.896602067956, 5200.92198617021, 5212.635115541913, 5237.6071794615555, 5080.0601888650535, 5128.615353848458, 5168.302279192318, 5178.223266510016, 5214.478552144793, 5156.097682905514, 5166.759977605385, 5174.66364686296, 5180.119379705459, 5201.479852014806, 4957.603391728653, 5036.244563315496, 5042.042012017705, 5060.3927528696795, 5173.9741301293625, 5424.294841670597, 5434.266374039533, 5443.945560544384, 5468.699221542814, 5475.753591088371, 5990.0, 6005.3394126646035, 6022.488088512482, 6050.21347224858, 6062.302835173923, 5940.168376427304, 6003.7898673546215, 6003.879922401571, 6007.729652165663, 6033.607815492023, 5590.888182236414, 5595.524380427669, 5596.244506991545, 5596.916046259309, 5610.24261724666, 6002.249718785152, 6110.3765049759795, 6120.112583675431, 6120.632762034292, 6159.353267906895, 6041.607295525777, 6065.2418447694035, 6077.787277445268, 6078.0882867569335, 6082.695865206722, 6137.140800287963, 6154.969225153935, 6158.014717645245, 6160.876782464416, 6161.969190154021, 5807.448292412214, 5955.374685657944, 6009.36901625323, 6050.606710563888, 6097.481714054266, 6040.667763272974, 6047.425494578008, 6056.424639659225, 6058.787942421994, 6061.0, 4565.817367305271, 4597.471290801601, 4601.608863246594, 4608.0, 4631.397918270603, 4048.2713111640187, 4117.629413352813, 4121.402396652528, 4140.254754144223, 4189.560096189917, 5585.162225666101, 5732.77068917247, 5794.942050579524, 5803.5357171426185, 5834.27071616048, 6038.365971572922, 6096.664683442365, 6097.573169878155, 6104.20645316106, 6111.327753947062, 5573.832785016456, 5647.887042259214, 5648.85877853057, 5735.4551317624755, 5762.798302059492, 5199.29809475716, 5213.817516386908, 5218.530332270114, 5218.895622087537, 5247.107991641354, 6198.783042593578, 6211.440970312694, 6211.81364559064, 6228.56400051992, 6238.282597501255, 5840.795572154954, 6014.097885317237, 6030.969845150834, 6034.064719968412, 6035.879282414239, 6156.907646385397, 6195.628262304096, 6207.193064901534, 6210.813675589739, 6211.9129152399055, 5922.318933322723, 5950.880982380241, 5959.4934430573885, 5980.222571065908, 5998.730057147526, 5830.737616807339, 5894.587378883437, 5936.079907614327, 6010.158577799024, 6047.425494578184, 5861.267341582302, 5878.911816322673, 5902.114682797443, 5902.498287645598, 5910.320313164041, 5869.941300586939, 5877.206577112035, 5889.882202356014, 5901.144334071621, 5909.734061967308, 5681.517071048842, 5719.428057194247, 5775.537956963517, 5776.393478684846, 5803.7678492861505, 5838.824835254949, 5874.794382196603, 5882.411758824083, 5893.970530147321, 5901.822945311647, 5657.010023245998, 5736.827895163152, 5786.247787787561, 5791.797287094932, 5805.390434004369], "unit": "score", "name": "dojo.html", "value": 5555.659838510073}, {"lowerIsBetter": false, "replicates": [527.7994362142383, 550.7081246939122, 572.2360648534207, 576.7635269539487, 603.1525706382529, 38991.41512877309, 39694.603053969455, 39710.60289397105, 39716.0, 39788.80105599475, 42335.788321058426, 42908.570914290845, 43026.99999999992, 43073.56926430735, 43136.56863431365, 8869.423487473327, 9015.549222538879, 9030.50332231727, 9065.22945549629, 9085.046070162636, 8847.513386763725, 9023.368364214508, 9043.276537876987, 9051.185393314601, 9078.727638170833, 9223.538823058854, 9230.861537076915, 9254.491002994866, 9303.25573954082, 9351.625934962593, 9124.543772811367, 9282.767930801716, 9285.350025498252, 9314.673986410444, 9320.813583728355, 9193.862092068624, 9268.304877134175, 9310.0, 9322.347435679505, 9327.720168394959, 44002.33996490055, 44860.0, 44904.55095449036, 45095.77452112751, 45100.54899450996, 3772.830222639988, 3812.0660438192544, 3922.0194951262183, 4193.35003074524, 4288.270993931039, 33384.83307583447, 33695.15762105942, 33697.66302336994, 33745.15637109067, 34376.82811585951, 4324.978375108104, 4345.826166953318, 4401.0, 4415.66882483815, 4499.887502812423, 280734.0, 281134.0, 282451.0, 283008.0, 283246.0, 46866.29700554494, 68602.0, 68883.0, 68887.0, 68978.31021689718, 46969.5303046972, 47120.7643961778, 47166.76416617895, 47200.05599888052, 47208.0, 17629.7355539667, 17653.20560574777, 17716.0, 17754.467365979042, 17778.111094445227, 14272.785908211385, 14368.353424095942, 14375.28123593816, 14376.928115359566, 14378.0, 15917.363305467652, 16031.0, 16096.67806643884, 16107.677846443006, 16157.030578165348, 6140.140380346666, 6176.567640265228, 6219.284782250009, 6222.937770622327, 6325.715342809584, 1002.0931057393071, 1042.3693665332517, 1051.264115119404, 1108.9243433869135, 1116.2242241642143, 29334.413311733646, 29962.250943726147, 30172.698273017428, 30554.236144096576, 30835.0, 1115.6919732991719, 1132.2017977325966, 1153.1293873125903, 1158.3571118029406, 1190.6070996571111, 15965.920170399073, 16028.839711602968, 16077.276522556513, 16176.838231617769, 16258.75611865823, 317746.0, 512245.0, 513617.0, 518960.0, 520645.0, 57697.4230257692, 58444.70777646085, 58619.70690146522, 58797.412025879195, 59241.703791480766, 1476.402057166849, 1502.3314624991992, 1507.2614418934643, 1520.6502504423822, 1562.0705680120311, 29836.403271934872, 30406.239844004078, 30560.235994100327, 31351.017398409374, 33271.0, 51166.74416627893, 52085.47914520958, 52217.0, 52619.473805261456, 52687.736561316946, 245180.0, 246157.0, 248115.0, 248461.0, 249585.0, 35487.290254195286, 52181.0, 52268.47731522636, 53128.0, 53855.73072134771, 49278.50721492739, 54511.18233226425, 55110.44889551053, 56261.718691406284, 57026.714866425405, 39464.0, 39572.40641390324, 39997.0, 40442.39336409897, 40963.0, 42077.579224207366, 44135.55864441315, 44157.0, 44575.33137003012, 44676.0, 45162.548374515834, 45772.31341529813, 46132.077358453316, 46398.0, 46666.533334666216, 36025.0, 36069.819650901576, 36194.45708314325, 36858.8157059213, 37352.62647373491, 28726.425471490034, 28946.131616051553, 29918.700812991592, 31693.207669807518, 32096.839515803207], "unit": "score", "name": "ext.html", "value": 20136.485842527414}, {"lowerIsBetter": false, "replicates": [376.90388950817544, 385.6760321330083, 386.9806509674517, 390.74211020726324, 396.7084193118056, 17597.47207583773, 18741.34405295815, 19018.2392704292, 19270.710939335888, 19343.613127737437, 17093.658126837487, 18160.18279177437, 18687.813121868778, 18704.532386690338, 18765.58759290083, 5036.874078148048, 5170.146925757245, 5198.584113270929, 5199.844004679866, 5214.973925130369, 5208.661437006583, 5443.374011988632, 5450.236966824647, 5469.726513674301, 5476.123820188771, 5403.567714582824, 5431.429699881515, 5558.44415558443, 6398.616083035009, 6407.295197528269, 6326.0, 6342.87314253717, 6365.108884756138, 6369.108324834527, 6412.583182093173, 5672.234248376458, 5689.800856969986, 5714.285714285715, 5724.169995350692, 5731.36954934961, 20910.686339704916, 21190.0, 21665.0, 22480.775192248195, 22489.887550562144, 2265.3204038788463, 2308.5382923415386, 2328.639060945556, 2696.1641891013846, 2747.32690490829, 10037.849432258521, 10642.414667193301, 11934.98552623028, 13354.332283385791, 14319.35562899672, 2006.8193862552441, 2068.586282743457, 2078.5842831433624, 2088.436122247, 2091.790820917896, 64287.0, 67705.3229467704, 68549.31450685479, 68759.31240687579, 69262.0, 10000.699979000641, 10350.792984140275, 10520.316179448311, 10549.683509494727, 10746.94626526878, 14169.362378692984, 14264.001519893716, 14335.426582936565, 14386.0, 14416.567502974927, 7862.488938218998, 8300.70947516834, 8329.50022998622, 8392.496450213006, 8457.450265732708, 8311.958440207882, 8373.330133589297, 8404.705835295736, 8445.437594045121, 8451.661933522713, 4160.479940007499, 4270.35944608305, 4472.664550158751, 4544.568266014723, 4559.635229181657, 1859.544411619135, 1896.5163883209693, 1908.9809101909082, 1915.8946257955947, 1923.144200830617, 975.7414285214423, 1035.203921196723, 1059.3802625464036, 1108.2740804772886, 1120.0815331428314, 14403.711925761427, 15233.466828660943, 16134.67730645404, 16894.239759210865, 18212.998285094447, 994.3735446668552, 1024.5850430575629, 1045.4506948908413, 1054.2620165883911, 1086.1907878630313, 9900.752481188028, 9987.350822196535, 10086.899131008742, 10097.394156350496, 10280.331778434527, 453641.0, 493694.0, 497411.0, 501601.0, 501764.0, 80690.59654701689, 80963.19036809674, 81490.59254703688, 82913.17086829175, 84443.15556844475, 1078.1374900079904, 1111.1333160135107, 1114.921955463126, 1128.6783266768932, 1133.8752737198902, 15998.760018599498, 16040.358385664442, 16117.0, 16263.430779922646, 16436.917815410845, 33510.32979340448, 33994.15014624654, 34567.827160864035, 35282.470762938065, 36007.0, 44781.0, 47440.0, 47621.76189119032, 47836.28245576389, 48754.512454876414, 8411.90645216118, 8459.91540084616, 8479.940007499063, 8495.235428811437, 8574.056853746208, 13126.540571079966, 13128.409221585243, 13314.86685133175, 13323.267220302976, 13379.799303010657, 10121.443320617142, 10283.588656453658, 11036.0, 11171.38557379352, 11708.824367634663, 11456.541738330374, 11634.011109055826, 11749.177557570887, 11753.588624398106, 11901.226420282654, 8449.493030418194, 9766.706998790047, 11377.601783937522, 11510.251833630788, 11596.304221746384, 8249.917500824915, 8382.958085209535, 8475.237228649452, 8492.02341730709, 8511.36164787631, 11190.384528850665, 11806.527738890349, 11827.290362578273, 11933.28400295985, 12163.81754273669], "unit": "score", "name": "jquery.html", "value": 8968.718881133675}, {"lowerIsBetter": false, "replicates": [1606.253092312075, 1606.6385063360744, 1905.9904700476495, 1945.571974165683, 2011.446852115669, 7774.53352798831, 8443.873341899862, 8618.525981071038, 8925.0, 8927.732168034961, 8548.316134709225, 8574.442661227016, 8674.392792504526, 8737.86893196601, 8756.562171891395, 2465.001674321898, 2486.875656217191, 2500.3999040230397, 2503.2615378463306, 2511.748825117492, 2399.9880000599974, 2488.5147396257735, 2492.8628925409093, 2499.550080985422, 2504.536660717764, 2435.2450740270574, 2466.2231397109945, 2467.284487498623, 2479.3305807431984, 2484.0, 2485.043258345541, 2489.7759201671756, 2496.563101457247, 2503.224000559814, 2531.6708827852353, 2479.256223133053, 2489.7759201671756, 2505.2233807519547, 2513.6606558114604, 2518.445941892799, 8960.417572857743, 9001.54992250385, 9001.549922503915, 9010.954945225232, 9016.639334426614, 5290.947090529084, 5467.043267428184, 5469.644473109235, 5471.534919531845, 5492.725363731797, 3349.514320423549, 3356.0938546592283, 3424.520567120605, 3431.1765176357494, 3461.913452163691, 969.5249327829313, 1027.2552399510296, 1035.9792804143951, 2095.5913596848623, 2104.116271166114, 12096.0, 12107.39463026845, 12191.512339506498, 12237.510499580007, 12237.755244895141, 4391.934120988188, 4433.268510695763, 4465.12929978651, 4506.076254367847, 4543.068670922453, 9636.084571965652, 9783.0706082922, 9798.314118011813, 9798.657047003464, 9835.213182945346, 5205.609579281569, 5253.238280449314, 5254.290670759475, 5259.421463638997, 5276.129438642581, 4751.952480475151, 4802.255650374128, 4883.706977581285, 4894.730789806524, 4903.950960490421, 3730.3658378075793, 3810.7523011004196, 3836.0985168485386, 3847.61523847613, 3871.922561548753, 1112.4703532642616, 1115.2694984784978, 1117.8826223246604, 1149.2816989381636, 1153.878842721519, 1457.5845883923032, 1464.0776310924264, 1473.8894582906325, 1490.8583684549951, 1496.0649594003748, 8566.657333706706, 8619.741407757778, 8630.568471576396, 8648.913510864937, 8661.22049015579, 522.5845452864982, 524.9448807875118, 535.068979974841, 569.4021277658442, 571.4799532425556, 6215.34738852423, 6226.0, 6240.095186198067, 6283.151774510383, 6297.433231009231, 10747.193960452842, 10979.1765617579, 11196.216264861381, 11231.550737970552, 11244.100471962223, 10478.423686697304, 10770.138388928866, 10797.676069717922, 10919.12646988239, 10957.616483423042, 8469.322454203771, 8480.067192608809, 8516.06323304436, 8534.274586660204, 8535.274501667303, 8109.1890810920795, 8132.75601731949, 8134.227248411392, 8270.917290827256, 8317.916820831715, 9574.994625564494, 9699.175570076623, 9815.901840981498, 9995.050470205319, 10046.748831279276, 9725.416475011521, 10041.297109202578, 10070.597176112873, 10275.0, 10304.484775761332, 7956.84086318282, 7974.0, 8030.478018928751, 8040.718574849852, 8054.8791768122355, 8531.93350831146, 8538.615762290836, 8544.0, 8554.27288680469, 8563.828723425371, 7855.33229675484, 7946.086200087064, 8001.279884810395, 8041.316488098343, 8065.1934806518875, 7811.921880781119, 7818.413618978486, 7887.487313324616, 7998.48009879356, 8015.278624923785, 8152.592370381576, 8155.959220203861, 8204.83590328202, 8229.0, 8325.95837020811, 7292.817679558054, 7295.890561641473, 7361.521501102411, 7372.299631534996, 7388.519746216693, 7421.183669796426, 7458.47790654649, 7478.102627684712, 7516.285952834472, 7618.69525218985], "unit": "score", "name": "mootools.html", "value": 4980.213736835548}, {"lowerIsBetter": false, "replicates": [348.80815551446705, 351.7590450541379, 357.29434367124946, 358.06366351989556, 358.14939518643223, 6375.298717141122, 6384.776532821346, 6393.36066393361, 6413.166288382516, 6420.3579642035775, 6334.556581039329, 6349.269833969095, 6349.936500634993, 6362.204724409449, 6380.04299355097, 4709.128811169944, 4809.086273608021, 4905.901881962359, 4917.852464426055, 4925.138100832358, 4864.927026094611, 4905.215165573509, 4908.0429316283335, 4924.384451943507, 4955.826546070888, 4869.659123861331, 4907.509249075082, 4912.508749125077, 4915.139850526161, 4918.286848406979, 4900.950990490085, 4913.508649135076, 4921.606271498272, 4925.31045653607, 4940.728259945701, 4331.306990881444, 4337.219300525904, 4341.9348709769065, 4346.174226896879, 4356.803943822536, 5911.9113213301835, 5984.281886173643, 6040.395960403968, 6043.758249670052, 6045.879082418371, 5743.9425605744245, 5776.537876969833, 5786.045302525078, 5787.6399046224105, 5792.710364481801, 6761.695723692396, 6771.153605799275, 6775.525713200078, 6775.593464392152, 6778.593284402951, 4825.4933232010835, 4827.975860120712, 4832.879178020543, 4835.516448355172, 4837.588804951583, 7050.29497050296, 7072.15134183896, 7077.646117694147, 7081.044059052014, 7084.220735719066, 4643.721376717408, 4824.541668541553, 4826.662133650681, 4830.3479030331155, 4970.130227210224, 4871.48849370811, 4891.413030436299, 4900.558949694473, 4902.362692849907, 4904.632152588499, 5630.915536266959, 5641.323041235078, 5673.858153546194, 5675.3757086720425, 5680.460356266148, 6839.965800170968, 6845.760398386033, 6847.246802851682, 6850.212225594021, 6852.211995620568, 1704.4204970309906, 1739.6346767178782, 1749.2915369275463, 1752.6845167869906, 1753.9561510962328, 1047.2878442658912, 1077.8113830079706, 1084.6366467233408, 1101.4437708956925, 1107.0811226681835, 6495.415412612888, 6519.4132528072705, 6523.641199733966, 6525.11910892033, 6535.705893234815, 6940.7917762467205, 6968.965155174192, 6974.79075627732, 6983.162020557464, 6989.091418115612, 6526.738930442729, 6572.14562106923, 6578.901316480256, 6587.50593705474, 6587.9670601646685, 3803.0, 3844.461775351453, 3847.3267178243696, 3854.3640299350855, 3854.845806167778, 7310.1593316768185, 7311.4516411268305, 7321.352695643438, 7325.377342925911, 7328.96335518319, 7061.470389720792, 7235.493515453868, 7270.563766174047, 7299.124105107421, 7299.781006569811, 7336.706531738778, 7374.410047196318, 7396.667149978264, 7405.074365704287, 7420.703171873172, 7096.680649370894, 7107.573545587281, 7121.893171602326, 7122.643867806485, 7137.179224389054, 6983.44132469391, 7015.333543313377, 7025.859482810213, 7044.330788575077, 7052.894206586802, 7226.277372262732, 7375.483716140034, 7383.778486645409, 7391.2978267064545, 7408.296211859864, 4823.710577365369, 4849.3210950467665, 4867.853964381075, 4880.731559764247, 4881.51184881509, 7109.253528379652, 7116.537425067354, 7116.786496405116, 7124.180719217149, 7128.429725622042, 6866.793996180123, 6880.311968803079, 6885.139357580302, 6889.655517224219, 6890.44876409896, 6752.088468056946, 6881.931180688129, 6881.965590172217, 6889.862202756017, 6892.276930767308, 6720.1263835703, 6761.121054262914, 6761.594304341756, 6765.932340676531, 6781.457483401217, 6859.348361905611, 6892.620905850226, 6920.965395173193, 6921.307869213038, 6925.0, 6661.866762664817, 6695.7321707133115, 6696.1629796275465, 6696.363845434676, 6728.428083612947], "unit": "score", "name": "prototype.html", "value": 5149.823693670244}, {"lowerIsBetter": false, "replicates": [810.9229623185796, 830.8936845097678, 864.2394692670453, 927.3230541704552, 931.594756281018, 14341.0, 14480.855191448083, 14621.268936553157, 14671.486497972573, 14705.55883323502, 13787.931060344685, 13801.240931748749, 13844.792328115087, 13888.652783680413, 13894.583162505141, 895.9776005599863, 930.6370515498961, 956.3496822160928, 956.3879117364858, 959.7216807125925, 934.2432629570036, 938.2962777916563, 942.2603256443693, 946.3801210207325, 947.5877993073001, 974.5663179884954, 991.7322322972793, 994.3188915592806, 995.1789773436907, 995.9302848800587, 972.363102168081, 974.3812678948883, 975.878015248094, 980.5440470181329, 980.6028558433845, 726.5640615630632, 729.1323325242944, 729.1396152540001, 731.0678884422404, 731.7438896386222, 14579.635509112251, 14606.780898286534, 14622.634434139125, 14678.559643210721, 14692.926535367362, 13756.518521851687, 13837.169769813843, 13863.861361386358, 13921.930390347983, 13997.3701183447, 11650.126240531994, 11714.121440891968, 11714.53141874324, 11881.524739010429, 11977.0, 3864.8647297344737, 3870.283997460479, 3886.747361421527, 3923.843046278174, 3962.445257663929, 50067.74966125146, 50375.24437133446, 50475.495245047445, 51046.0, 51393.486065139616, 10908.945455272673, 10984.340939543654, 11013.394263315435, 11060.944695276472, 11118.0, 17483.56291092733, 17611.207495662726, 17612.0, 17637.382691605733, 19579.216831326587, 8486.278666313308, 8560.0583935767, 8638.09300023501, 8676.78308042304, 8678.349123815738, 4804.975975120172, 4905.509449055137, 5007.4491805901325, 5008.924866127011, 5123.897522049613, 3465.8440370183403, 3465.9480107798404, 3467.7745946513396, 3486.1981744198974, 3504.1940353718787, 645.0710976194265, 650.4211251985737, 654.9803505894831, 657.044000978575, 659.1891972873393, 610.4719417703743, 690.7168061094927, 716.7921302822227, 730.9246493938724, 751.7970148059993, 8696.78258043554, 8863.64545418189, 8976.8653470198, 9053.502057386908, 9181.35730498872, 575.3728436004691, 617.5183356981562, 666.7999600119945, 698.7798843364324, 700.7617410080597, 4105.445764821711, 4277.251480990814, 4350.499692535335, 4393.450818647669, 4428.579284967923, 55409.44590554124, 55703.0, 55772.72113639406, 56262.156067659016, 56426.43573564294, 49495.0, 50444.74777626088, 50887.7455612727, 51355.0, 51357.0, 47028.76485617618, 47067.0, 47238.763806181436, 47554.76222618934, 47827.52172478231, 8207.425480216567, 8291.83416331682, 8414.453060551044, 8505.95747021261, 8693.304535637008, 34874.47688284729, 35563.0, 36819.26361472702, 36894.63105368912, 37018.25963480769, 39552.40671389874, 40476.1904761909, 44380.0, 45526.089478209586, 45853.0, 10336.224783141444, 10579.841302380624, 10584.947075264574, 10616.787664246825, 10692.411917344622, 11540.076793856639, 11585.402392984732, 11668.299902005567, 11698.883011169779, 11722.413879306172, 11087.778244434905, 11305.7738845221, 11630.70923226926, 11684.065274778168, 12052.75894482123, 11163.548738663922, 11193.72015699614, 11289.0, 11366.659000230007, 11623.6512904613, 11516.366599837089, 12488.25070495773, 12720.6819829505, 12853.614391568268, 13238.735225295633, 10655.25413221067, 10784.245102842726, 10788.784224315314, 10999.560017599206, 11080.279781814157, 10377.377357358582, 10522.421266830092, 10534.683959481228, 10538.525766340379, 10662.253642244968], "unit": "score", "name": "yui.html", "value": 6753.026988093033}], "name": "dromaeo_css", "value": 7470.287079040972}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 112.0, 112.0, 113.0, 121.0, 111.0, 109.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [155.0, 127.0, 155.0, 165.0, 128.0, 156.0, 159.0, 137.0, 184.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 171.0, 163.0, 163.0, 162.0, 164.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 76.0, 168.0, 74.0, 76.0, 76.0, 77.0, 159.0, 78.0], "unit": "score", "name": "audio-fft", "value": 93.6}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 147.0, 95.0, 94.0, 93.0, 144.0, 93.0, 93.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 148.0, 146.0, 145.0, 146.0, 147.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 98.0, 95.0, 97.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 58.0, 60.0, 58.0, 57.0, 57.0, 67.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 72.0, 74.0, 73.0, 72.0, 73.0, 73.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.3}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 80.0, 78.0, 78.0, 80.0, 80.0, 83.0, 80.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.3}, {"lowerIsBetter": true, "replicates": [115.0, 129.0, 119.0, 114.0, 115.0, 116.0, 117.0, 115.0, 123.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.8}, {"lowerIsBetter": true, "replicates": [137.0, 149.0, 151.0, 151.0, 153.0, 146.0, 155.0, 145.0, 146.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.9}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 70.0, 68.0, 74.0, 67.0, 67.0, 71.0, 67.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1532.4}]} 23:48:05 INFO - Return code: 0 23:48:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:48:05 ERROR - # TBPL SUCCESS # 23:48:05 INFO - Running post-action listener: _resource_record_post_action 23:48:05 INFO - Running post-run listener: _resource_record_post_run 23:48:06 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 16384; Write bytes: 225652736; Read time: 32; Write time: 112796 23:48:06 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 4648960; Read time: 0; Write time: 332 23:48:06 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 16384; Write bytes: 221003776; Read time: 32; Write time: 112464 23:48:06 INFO - Running post-run listener: _upload_blobber_files 23:48:06 INFO - Blob upload gear active. 23:48:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:48:06 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 23:48:06 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'] 23:48:06 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 23:48:06 INFO - (blobuploader) - INFO - Open directory for files ... 23:48:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:48:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:48:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:48:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:48:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:48:07 INFO - (blobuploader) - INFO - Done attempting. 23:48:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:48:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:48:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:48:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:48:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:48:08 INFO - (blobuploader) - INFO - Done attempting. 23:48:08 INFO - (blobuploader) - INFO - Iteration through files over. 23:48:08 INFO - Return code: 0 23:48:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:48:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:48:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/768e5bc3921188c087173839285bea7347379558816e3dc63a76230446723e7cb626ca9474cfd02bbc72dffd844d4cb812178ab251985c03892ee031f57ad43d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae82e58adcf1c48f28dd81a4c76fc8a6d1a506d9a98b414faefb816d34440cae09883cd332a576e6648daa10ecca7e32dac7648ad4910585038cbbb06c5db7bc"} 23:48:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:48:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:48:08 INFO - Contents: 23:48:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/768e5bc3921188c087173839285bea7347379558816e3dc63a76230446723e7cb626ca9474cfd02bbc72dffd844d4cb812178ab251985c03892ee031f57ad43d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae82e58adcf1c48f28dd81a4c76fc8a6d1a506d9a98b414faefb816d34440cae09883cd332a576e6648daa10ecca7e32dac7648ad4910585038cbbb06c5db7bc"} 23:48:08 INFO - Running post-run listener: copy_logs_to_upload_dir 23:48:08 INFO - Copying logs to upload dir... 23:48:08 INFO - mkdir: /builds/slave/test/build/upload/logs 23:48:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.761736 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-25 23:48:08.453033) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 23:48:08.456332) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842 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/768e5bc3921188c087173839285bea7347379558816e3dc63a76230446723e7cb626ca9474cfd02bbc72dffd844d4cb812178ab251985c03892ee031f57ad43d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae82e58adcf1c48f28dd81a4c76fc8a6d1a506d9a98b414faefb816d34440cae09883cd332a576e6648daa10ecca7e32dac7648ad4910585038cbbb06c5db7bc"} build_url:https://queue.taskcluster.net/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011241 build_url: 'https://queue.taskcluster.net/v1/task/f2H4qtKsTHSXcpzI1Lqw0g/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/768e5bc3921188c087173839285bea7347379558816e3dc63a76230446723e7cb626ca9474cfd02bbc72dffd844d4cb812178ab251985c03892ee031f57ad43d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae82e58adcf1c48f28dd81a4c76fc8a6d1a506d9a98b414faefb816d34440cae09883cd332a576e6648daa10ecca7e32dac7648ad4910585038cbbb06c5db7bc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 23:48:08.482571) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 23:48:08.482891) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461651952.772793-185833842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004367 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 23:48:08.564569) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 23:48:08.564872) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 23:48:08.565152) ========= ========= Total master_lag: 0.16 =========