builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1466448805.42 results: success (0) buildid: 20160620091522 builduid: c39846555818425ba42f227235a9f59f revision: 9798772706750302d87a689cbbf056ae04244f80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 11:53:25.417425) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 11:53:25.418001) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 11:53:25.418301) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 11:53:25.433820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 11:53:25.434543) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-20 11:53:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-06-20 11:53:25 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127407 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 11:53:25.575976) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 11:53:25.576316) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020095 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 11:53:25.625250) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-20 11:53:25.625638) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9798772706750302d87a689cbbf056ae04244f80 --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 9798772706750302d87a689cbbf056ae04244f80 --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=337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-20 11:53:25,875 truncating revision to first 12 chars 2016-06-20 11:53:25,876 Setting DEBUG logging. 2016-06-20 11:53:25,876 attempt 1/10 2016-06-20 11:53:25,876 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/979877270675?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-20 11:53:26,847 unpacking tar archive at: mozilla-beta-979877270675/testing/mozharness/ program finished with exit code 0 elapsedTime=1.270622 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-20 11:53:26.912011) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 11:53:26.912483) ========= script_repo_revision: 9798772706750302d87a689cbbf056ae04244f80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 11:53:26.913081) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 11:53:26.913490) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 11:53:26.929724) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-06-20 11:53:26.930279) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:53:27 INFO - MultiFileLogger online at 20160620 11:53:27 in /builds/slave/test 11:53:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:53:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:53:27 INFO - {'append_to_log': False, 11:53:27 INFO - 'base_work_dir': '/builds/slave/test', 11:53:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:53:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:53:27 INFO - 'branch': 'Mozilla-Beta', 11:53:27 INFO - 'buildbot_json_path': 'buildprops.json', 11:53:27 INFO - 'config_files': ('talos/linux_config.py',), 11:53:27 INFO - 'default_actions': ('clobber', 11:53:27 INFO - 'read-buildbot-config', 11:53:27 INFO - 'download-and-extract', 11:53:27 INFO - 'populate-webroot', 11:53:27 INFO - 'create-virtualenv', 11:53:27 INFO - 'install', 11:53:27 INFO - 'run-tests'), 11:53:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:53:27 INFO - 'download_minidump_stackwalk': True, 11:53:27 INFO - 'download_symbols': 'ondemand', 11:53:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:53:27 INFO - 'tooltool.py': '/tools/tooltool.py', 11:53:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:53:27 INFO - '/tools/misc-python/virtualenv.py')}, 11:53:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:53:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:53:27 INFO - 'installer_path': 'installer.exe', 11:53:27 INFO - 'log_level': 'info', 11:53:27 INFO - 'log_name': 'talos', 11:53:27 INFO - 'log_to_console': True, 11:53:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:53:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:53:27 INFO - 'opt_config_files': (), 11:53:27 INFO - 'pip_index': False, 11:53:27 INFO - 'sps_profile': False, 11:53:27 INFO - 'sps_profile_interval': 0, 11:53:27 INFO - 'suite': 'dromaeojs', 11:53:27 INFO - 'system_bits': '32', 11:53:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:53:27 INFO - 'title': 'talos-linux64-ix-060', 11:53:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:53:27 INFO - 'use_talos_json': True, 11:53:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:53:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:53:27 INFO - 'work_dir': 'build'} 11:53:27 INFO - ##### 11:53:27 INFO - ##### Running clobber step. 11:53:27 INFO - ##### 11:53:27 INFO - Running pre-action listener: _resource_record_pre_action 11:53:27 INFO - Running main action method: clobber 11:53:27 INFO - rmtree: /builds/slave/test/build 11:53:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:53:28 INFO - Running post-action listener: _resource_record_post_action 11:53:28 INFO - ##### 11:53:28 INFO - ##### Running read-buildbot-config step. 11:53:28 INFO - ##### 11:53:28 INFO - Running pre-action listener: _resource_record_pre_action 11:53:28 INFO - Running main action method: read_buildbot_config 11:53:28 INFO - Using buildbot properties: 11:53:28 INFO - { 11:53:28 INFO - "project": "", 11:53:28 INFO - "product": "firefox", 11:53:28 INFO - "script_repo_revision": "production", 11:53:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:53:28 INFO - "repository": "", 11:53:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:53:28 INFO - "buildid": "20160620091522", 11:53:28 INFO - "pgo_build": "True", 11:53:28 INFO - "basedir": "/builds/slave/test", 11:53:28 INFO - "buildnumber": 48, 11:53:28 INFO - "slavename": "talos-linux64-ix-060", 11:53:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:53:28 INFO - "platform": "ubuntu64_hw", 11:53:28 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:53:28 INFO - "branch": "mozilla-beta", 11:53:28 INFO - "repo_path": "releases/mozilla-beta", 11:53:28 INFO - "revision": "9798772706750302d87a689cbbf056ae04244f80", 11:53:28 INFO - "stage_platform": "linux64-pgo", 11:53:28 INFO - "builduid": "c39846555818425ba42f227235a9f59f", 11:53:28 INFO - "slavebuilddir": "test" 11:53:28 INFO - } 11:53:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 11:53:28 INFO - Running post-action listener: _resource_record_post_action 11:53:28 INFO - ##### 11:53:28 INFO - ##### Running download-and-extract step. 11:53:28 INFO - ##### 11:53:28 INFO - Running pre-action listener: _resource_record_pre_action 11:53:28 INFO - Running main action method: download_and_extract 11:53:28 INFO - mkdir: /builds/slave/test/build/tests 11:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:28 INFO - https://queue.taskcluster.net/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:53:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:53:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:53:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:53:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:53:29 INFO - Downloaded 1327 bytes. 11:53:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:53:29 INFO - Using the following test package requirements: 11:53:29 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 11:53:29 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:53:29 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:53:29 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:53:29 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 11:53:29 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:53:29 INFO - u'jsshell-linux-x86_64.zip'], 11:53:29 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:53:29 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:53:29 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 11:53:29 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:53:29 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 11:53:29 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:53:29 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 11:53:29 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:53:29 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:53:29 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:53:29 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:53:29 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:53:29 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')]} 11:53:29 INFO - https://queue.taskcluster.net/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:53:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:53:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:53:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:53:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:53:30 INFO - Downloaded 24185645 bytes. 11:53:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:53:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:53:31 INFO - Return code: 0 11:53:31 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:31 INFO - https://queue.taskcluster.net/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:53:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:53:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:53:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:53:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:53:32 INFO - Downloaded 24185645 bytes. 11:53:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:53:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:53:34 INFO - Return code: 0 11:53: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')]} 11:53:34 INFO - https://queue.taskcluster.net/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:53:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 11:53:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 11:53:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 11:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:53:35 INFO - Downloaded 10840145 bytes. 11:53:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:53:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:53:36 INFO - Return code: 0 11:53: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')]} 11:53:36 INFO - https://queue.taskcluster.net/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:53:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:53:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:53:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:53:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:53:39 INFO - Downloaded 56007064 bytes. 11:53:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:53:39 INFO - mkdir: /builds/slave/test/properties 11:53:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:53:39 INFO - Writing to file /builds/slave/test/properties/build_url 11:53:39 INFO - Contents: 11:53:39 INFO - build_url:https://queue.taskcluster.net/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:53:40 INFO - Running post-action listener: _resource_record_post_action 11:53:40 INFO - Running post-action listener: set_extra_try_arguments 11:53:40 INFO - ##### 11:53:40 INFO - ##### Running populate-webroot step. 11:53:40 INFO - ##### 11:53:40 INFO - Running pre-action listener: _resource_record_pre_action 11:53:40 INFO - Running main action method: populate_webroot 11:53:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:53:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:53:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:53:40 INFO - '--tppagecycles', 11:53:40 INFO - '7'], 11:53:40 INFO - 'tests': ['tsvgm']}}, 11:53:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:53:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:53:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:53:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:53:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:53:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:53:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:40 INFO - 'talos_options': ['--disable-e10s'], 11:53:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:53:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:53:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:40 INFO - 'talos_options': ['--disable-e10s'], 11:53:40 INFO - 'tests': ['damp', 'tps']}, 11:53:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:40 INFO - 'tests': ['damp', 'tps']}, 11:53:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:53:40 INFO - 'tests': ['dromaeo_dom']}, 11:53:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:53:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:53:40 INFO - 'tests': ['a11yr', 11:53:40 INFO - 'ts_paint', 11:53:40 INFO - 'tpaint', 11:53:40 INFO - 'sessionrestore', 11:53:40 INFO - 'sessionrestore_no_auto_restore', 11:53:40 INFO - 'tabpaint']}, 11:53:40 INFO - 'other-e10s': {'tests': ['a11yr', 11:53:40 INFO - 'ts_paint', 11:53:40 INFO - 'tpaint', 11:53:40 INFO - 'sessionrestore', 11:53:40 INFO - 'sessionrestore_no_auto_restore', 11:53:40 INFO - 'tabpaint']}, 11:53:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:53:40 INFO - 'ts_paint', 11:53:40 INFO - 'tpaint', 11:53:40 INFO - 'sessionrestore', 11:53:40 INFO - 'sessionrestore_no_auto_restore', 11:53:40 INFO - 'tabpaint']}, 11:53:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:53:40 INFO - 'ts_paint', 11:53:40 INFO - 'tpaint', 11:53:40 INFO - 'sessionrestore', 11:53:40 INFO - 'sessionrestore_no_auto_restore', 11:53:40 INFO - 'tabpaint']}, 11:53:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:53:40 INFO - 'tests': ['a11yr', 11:53:40 INFO - 'ts_paint', 11:53:40 INFO - 'tpaint', 11:53:40 INFO - 'sessionrestore', 11:53:40 INFO - 'sessionrestore_no_auto_restore', 11:53:40 INFO - 'tabpaint']}, 11:53:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:53:40 INFO - 'tests': ['a11yr', 11:53:40 INFO - 'ts_paint', 11:53:40 INFO - 'tpaint', 11:53:40 INFO - 'sessionrestore', 11:53:40 INFO - 'sessionrestore_no_auto_restore', 11:53:40 INFO - 'tabpaint']}, 11:53:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:53:40 INFO - 'tests': ['tsvgx', 11:53:40 INFO - 'tsvgr_opacity', 11:53:40 INFO - 'tart', 11:53:40 INFO - 'tscrollx', 11:53:40 INFO - 'cart']}, 11:53:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:53:40 INFO - 'tsvgr_opacity', 11:53:40 INFO - 'tart', 11:53:40 INFO - 'tscrollx', 11:53:40 INFO - 'cart']}, 11:53:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:40 INFO - 'talos_options': ['--disable-e10s'], 11:53:40 INFO - 'tests': ['tp5o']}, 11:53:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:40 INFO - 'tests': ['tp5o']}, 11:53:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:40 INFO - 'talos_options': ['--disable-e10s', 11:53:40 INFO - '--xperf_path', 11:53:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:53:40 INFO - 'tests': ['tp5n']}, 11:53:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:40 INFO - 'talos_options': ['--xperf_path', 11:53:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:53:40 INFO - 'tests': ['tp5n']}}, 11:53:40 INFO - 'talos.zip': {'path': '', 11:53:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:53:40 INFO - Running post-action listener: _resource_record_post_action 11:53:40 INFO - ##### 11:53:40 INFO - ##### Running create-virtualenv step. 11:53:40 INFO - ##### 11:53:40 INFO - Running pre-action listener: _resource_record_pre_action 11:53:40 INFO - Running main action method: create_virtualenv 11:53:40 INFO - Creating virtualenv /builds/slave/test/build/venv 11:53:40 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 11:53:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:53:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:53:40 INFO - Using real prefix '/usr' 11:53:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:53:41 INFO - Installing distribute.............................................................................................................................................................................................done. 11:53:43 INFO - Installing pip.................done. 11:53:43 INFO - Return code: 0 11:53:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7effb7906f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d410>, '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 0x1e0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', '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 11:53:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:53:43 INFO - Using env: {'DISPLAY': ':0', 11:53:43 INFO - 'HOME': '/home/cltbld', 11:53:43 INFO - 'LANG': 'en_US.UTF-8', 11:53:43 INFO - 'LANGUAGE': 'en_US:en', 11:53:43 INFO - 'LOGNAME': 'cltbld', 11:53:43 INFO - 'MAIL': '/var/mail/cltbld', 11:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:43 INFO - 'MOZ_NO_REMOTE': '1', 11:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:43 INFO - 'NO_EM_RESTART': '1', 11:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:43 INFO - 'PWD': '/builds/slave/test', 11:53:43 INFO - 'SHELL': '/bin/bash', 11:53:43 INFO - 'SHLVL': '1', 11:53:43 INFO - 'TERM': 'linux', 11:53:43 INFO - 'TMOUT': '86400', 11:53:43 INFO - 'USER': 'cltbld', 11:53:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', 11:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:43 INFO - '_': '/tools/buildbot/bin/python'} 11:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:43 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 11:53:43 INFO - Cleaning up... 11:53:43 INFO - Return code: 0 11:53:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7effb7906f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d410>, '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 0x1e0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', '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 11:53:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:53:43 INFO - Using env: {'DISPLAY': ':0', 11:53:43 INFO - 'HOME': '/home/cltbld', 11:53:43 INFO - 'LANG': 'en_US.UTF-8', 11:53:43 INFO - 'LANGUAGE': 'en_US:en', 11:53:43 INFO - 'LOGNAME': 'cltbld', 11:53:43 INFO - 'MAIL': '/var/mail/cltbld', 11:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:43 INFO - 'MOZ_NO_REMOTE': '1', 11:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:43 INFO - 'NO_EM_RESTART': '1', 11:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:43 INFO - 'PWD': '/builds/slave/test', 11:53:43 INFO - 'SHELL': '/bin/bash', 11:53:43 INFO - 'SHLVL': '1', 11:53:43 INFO - 'TERM': 'linux', 11:53:43 INFO - 'TMOUT': '86400', 11:53:43 INFO - 'USER': 'cltbld', 11:53:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', 11:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:43 INFO - '_': '/tools/buildbot/bin/python'} 11:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:43 INFO - Downloading/unpacking psutil>=0.7.1 11:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:53:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:53:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:53:45 INFO - Installing collected packages: psutil 11:53:45 INFO - Running setup.py install for psutil 11:53:45 INFO - building 'psutil._psutil_linux' extension 11:53:45 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 11:53:45 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 11:53:45 INFO - building 'psutil._psutil_posix' extension 11:53:45 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 11:53:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:53:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:53:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:53:46 INFO - Successfully installed psutil 11:53:46 INFO - Cleaning up... 11:53:46 INFO - Return code: 0 11:53:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7effb7906f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d410>, '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 0x1e0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', '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 11:53:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:53:46 INFO - Using env: {'DISPLAY': ':0', 11:53:46 INFO - 'HOME': '/home/cltbld', 11:53:46 INFO - 'LANG': 'en_US.UTF-8', 11:53:46 INFO - 'LANGUAGE': 'en_US:en', 11:53:46 INFO - 'LOGNAME': 'cltbld', 11:53:46 INFO - 'MAIL': '/var/mail/cltbld', 11:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:46 INFO - 'MOZ_NO_REMOTE': '1', 11:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:46 INFO - 'NO_EM_RESTART': '1', 11:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:46 INFO - 'PWD': '/builds/slave/test', 11:53:46 INFO - 'SHELL': '/bin/bash', 11:53:46 INFO - 'SHLVL': '1', 11:53:46 INFO - 'TERM': 'linux', 11:53:46 INFO - 'TMOUT': '86400', 11:53:46 INFO - 'USER': 'cltbld', 11:53:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', 11:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:46 INFO - '_': '/tools/buildbot/bin/python'} 11:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:53:48 INFO - Installing collected packages: mozsystemmonitor 11:53:48 INFO - Running setup.py install for mozsystemmonitor 11:53:48 INFO - Successfully installed mozsystemmonitor 11:53:48 INFO - Cleaning up... 11:53:48 INFO - Return code: 0 11:53:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7effb7906f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d410>, '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 0x1e0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', '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 11:53:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:53:48 INFO - Using env: {'DISPLAY': ':0', 11:53:48 INFO - 'HOME': '/home/cltbld', 11:53:48 INFO - 'LANG': 'en_US.UTF-8', 11:53:48 INFO - 'LANGUAGE': 'en_US:en', 11:53:48 INFO - 'LOGNAME': 'cltbld', 11:53:48 INFO - 'MAIL': '/var/mail/cltbld', 11:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:48 INFO - 'MOZ_NO_REMOTE': '1', 11:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:48 INFO - 'NO_EM_RESTART': '1', 11:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:48 INFO - 'PWD': '/builds/slave/test', 11:53:48 INFO - 'SHELL': '/bin/bash', 11:53:48 INFO - 'SHLVL': '1', 11:53:48 INFO - 'TERM': 'linux', 11:53:48 INFO - 'TMOUT': '86400', 11:53:48 INFO - 'USER': 'cltbld', 11:53:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', 11:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:48 INFO - '_': '/tools/buildbot/bin/python'} 11:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:48 INFO - Downloading/unpacking blobuploader==1.2.4 11:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:50 INFO - Downloading blobuploader-1.2.4.tar.gz 11:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:53:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:53:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:51 INFO - Downloading docopt-0.6.1.tar.gz 11:53:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:53:51 INFO - Installing collected packages: blobuploader, requests, docopt 11:53:51 INFO - Running setup.py install for blobuploader 11:53:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:53:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:53:51 INFO - Running setup.py install for requests 11:53:51 INFO - Running setup.py install for docopt 11:53:51 INFO - Successfully installed blobuploader requests docopt 11:53:51 INFO - Cleaning up... 11:53:51 INFO - Return code: 0 11:53:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:53:51 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')]} 11:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:51 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')]} 11:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:51 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 0x7effb7906f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d410>, '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 0x1e0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', '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 11:53:51 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 11:53:51 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 11:53:51 INFO - Using env: {'DISPLAY': ':0', 11:53:51 INFO - 'HOME': '/home/cltbld', 11:53:51 INFO - 'LANG': 'en_US.UTF-8', 11:53:51 INFO - 'LANGUAGE': 'en_US:en', 11:53:51 INFO - 'LOGNAME': 'cltbld', 11:53:51 INFO - 'MAIL': '/var/mail/cltbld', 11:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:51 INFO - 'MOZ_NO_REMOTE': '1', 11:53:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:51 INFO - 'NO_EM_RESTART': '1', 11:53:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:51 INFO - 'PWD': '/builds/slave/test', 11:53:51 INFO - 'SHELL': '/bin/bash', 11:53:51 INFO - 'SHLVL': '1', 11:53:51 INFO - 'TERM': 'linux', 11:53:51 INFO - 'TMOUT': '86400', 11:53:51 INFO - 'USER': 'cltbld', 11:53:51 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', 11:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:51 INFO - '_': '/tools/buildbot/bin/python'} 11:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:53:52 INFO - Running setup.py (path:/tmp/pip-mYItk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:53:52 INFO - Running setup.py (path:/tmp/pip-RNwIru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:53:52 INFO - Running setup.py (path:/tmp/pip-5ydexN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:53:52 INFO - Running setup.py (path:/tmp/pip-zsgq5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:53:52 INFO - Running setup.py (path:/tmp/pip-BChBa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:53:52 INFO - Running setup.py (path:/tmp/pip-ytpXUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:53:52 INFO - Running setup.py (path:/tmp/pip-LbLJdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:53:52 INFO - Running setup.py (path:/tmp/pip-CEyrdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:53:52 INFO - Running setup.py (path:/tmp/pip-g6B8fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:53:52 INFO - Running setup.py (path:/tmp/pip-8UHgm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:53:52 INFO - Running setup.py (path:/tmp/pip-nGklZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:53:52 INFO - Running setup.py (path:/tmp/pip-jaxhtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:53:53 INFO - Running setup.py (path:/tmp/pip-2yemlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:53:53 INFO - Running setup.py (path:/tmp/pip-8bDrT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:53 INFO - Running setup.py (path:/tmp/pip-M8V3mY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:53:53 INFO - Running setup.py (path:/tmp/pip-5Tioq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:53:53 INFO - Running setup.py (path:/tmp/pip-VoReaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:53:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:53:53 INFO - Running setup.py install for manifestparser 11:53:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:53:53 INFO - Running setup.py install for mozcrash 11:53:53 INFO - Running setup.py install for mozdebug 11:53:53 INFO - Running setup.py install for mozdevice 11:53:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:53:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:53:53 INFO - Running setup.py install for mozfile 11:53:53 INFO - Running setup.py install for mozhttpd 11:53:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:53:54 INFO - Running setup.py install for mozinfo 11:53:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:53:54 INFO - Running setup.py install for mozInstall 11:53:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:53:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:53:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:53:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:53:54 INFO - Running setup.py install for mozleak 11:53:54 INFO - Running setup.py install for mozlog 11:53:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:53:54 INFO - Running setup.py install for moznetwork 11:53:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:53:54 INFO - Running setup.py install for mozprocess 11:53:54 INFO - Running setup.py install for mozprofile 11:53:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:53:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:53:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:53:54 INFO - Running setup.py install for mozrunner 11:53:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:53:54 INFO - Running setup.py install for mozscreenshot 11:53:54 INFO - Running setup.py install for moztest 11:53:55 INFO - Running setup.py install for mozversion 11:53:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:53:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:53:55 INFO - Cleaning up... 11:53:55 INFO - Return code: 0 11:53:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:53:55 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')]} 11:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:55 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')]} 11:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:55 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 0x7effb7906f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d410>, '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 0x1e0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', '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 11:53:55 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 11:53:55 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 11:53:55 INFO - Using env: {'DISPLAY': ':0', 11:53:55 INFO - 'HOME': '/home/cltbld', 11:53:55 INFO - 'LANG': 'en_US.UTF-8', 11:53:55 INFO - 'LANGUAGE': 'en_US:en', 11:53:55 INFO - 'LOGNAME': 'cltbld', 11:53:55 INFO - 'MAIL': '/var/mail/cltbld', 11:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:55 INFO - 'MOZ_NO_REMOTE': '1', 11:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:55 INFO - 'NO_EM_RESTART': '1', 11:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:55 INFO - 'PWD': '/builds/slave/test', 11:53:55 INFO - 'SHELL': '/bin/bash', 11:53:55 INFO - 'SHLVL': '1', 11:53:55 INFO - 'TERM': 'linux', 11:53:55 INFO - 'TMOUT': '86400', 11:53:55 INFO - 'USER': 'cltbld', 11:53:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', 11:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:55 INFO - '_': '/tools/buildbot/bin/python'} 11:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:53:55 INFO - Running setup.py (path:/tmp/pip-pM0RaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:53:55 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)) 11:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:53:55 INFO - Running setup.py (path:/tmp/pip-t5u0gG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:53:55 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)) 11:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:53:55 INFO - Running setup.py (path:/tmp/pip-lvRPIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:53:55 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)) 11:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:53:55 INFO - Running setup.py (path:/tmp/pip-PmrZ77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:53:55 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)) 11:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:53:55 INFO - Running setup.py (path:/tmp/pip-4SvW0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:53:55 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)) 11:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:53:55 INFO - Running setup.py (path:/tmp/pip-J_Z3bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:53:55 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)) 11:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:53:55 INFO - Running setup.py (path:/tmp/pip-CuG3so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:53:55 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)) 11:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:53:55 INFO - Running setup.py (path:/tmp/pip-NK8eP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:53:55 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)) 11:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:53:55 INFO - Running setup.py (path:/tmp/pip-gcYBwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:53:56 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)) 11:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:53:56 INFO - Running setup.py (path:/tmp/pip-R7nMZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:53:56 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)) 11:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:53:56 INFO - Running setup.py (path:/tmp/pip-UVinfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:53:56 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)) 11:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:53:56 INFO - Running setup.py (path:/tmp/pip-tYUOhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:53:56 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)) 11:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:53:56 INFO - Running setup.py (path:/tmp/pip-jrBlLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:53:56 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)) 11:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:53:56 INFO - Running setup.py (path:/tmp/pip-nvbYKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:53:56 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)) 11:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:56 INFO - Running setup.py (path:/tmp/pip-2KGeZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:56 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)) 11:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:53:56 INFO - Running setup.py (path:/tmp/pip-m7gUy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:53:56 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)) 11:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:53:56 INFO - Running setup.py (path:/tmp/pip-HPtjRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:53:56 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)) 11:53:56 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)) 11:53:56 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)) 11:53:56 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)) 11:53:56 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)) 11:53:56 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)) 11:53:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:58 INFO - Downloading blessings-1.6.tar.gz 11:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:53:58 INFO - Installing collected packages: blessings 11:53:58 INFO - Running setup.py install for blessings 11:53:58 INFO - Successfully installed blessings 11:53:58 INFO - Cleaning up... 11:53:58 INFO - Return code: 0 11:53:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:53:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:53:59 INFO - Reading from file tmpfile_stdout 11:53:59 INFO - Current package versions: 11:53:59 INFO - argparse == 1.2.1 11:53:59 INFO - blessings == 1.6 11:53:59 INFO - blobuploader == 1.2.4 11:53:59 INFO - docopt == 0.6.1 11:53:59 INFO - manifestparser == 1.1 11:53:59 INFO - mozInstall == 1.12 11:53:59 INFO - mozcrash == 0.17 11:53:59 INFO - mozdebug == 0.1 11:53:59 INFO - mozdevice == 0.48 11:53:59 INFO - mozfile == 1.2 11:53:59 INFO - mozhttpd == 0.7 11:53:59 INFO - mozinfo == 0.9 11:53:59 INFO - mozleak == 0.1 11:53:59 INFO - mozlog == 3.1 11:53:59 INFO - moznetwork == 0.27 11:53:59 INFO - mozprocess == 0.22 11:53:59 INFO - mozprofile == 0.28 11:53:59 INFO - mozrunner == 6.11 11:53:59 INFO - mozscreenshot == 0.1 11:53:59 INFO - mozsystemmonitor == 0.0 11:53:59 INFO - moztest == 0.7 11:53:59 INFO - mozversion == 1.4 11:53:59 INFO - psutil == 3.1.1 11:53:59 INFO - requests == 1.2.3 11:53:59 INFO - wsgiref == 0.1.2 11:53:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:53: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')]} 11:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53: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')]} 11:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:59 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 0x7effb7906f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d410>, '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 0x1e0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', '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 11:53:59 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 11:53:59 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 11:53:59 INFO - Using env: {'DISPLAY': ':0', 11:53:59 INFO - 'HOME': '/home/cltbld', 11:53:59 INFO - 'LANG': 'en_US.UTF-8', 11:53:59 INFO - 'LANGUAGE': 'en_US:en', 11:53:59 INFO - 'LOGNAME': 'cltbld', 11:53:59 INFO - 'MAIL': '/var/mail/cltbld', 11:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:59 INFO - 'MOZ_NO_REMOTE': '1', 11:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:59 INFO - 'NO_EM_RESTART': '1', 11:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:59 INFO - 'PWD': '/builds/slave/test', 11:53:59 INFO - 'SHELL': '/bin/bash', 11:53:59 INFO - 'SHLVL': '1', 11:53:59 INFO - 'TERM': 'linux', 11:53:59 INFO - 'TMOUT': '86400', 11:53:59 INFO - 'USER': 'cltbld', 11:53:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', 11:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:59 INFO - '_': '/tools/buildbot/bin/python'} 11:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 INFO - Cleaning up... 11:53:59 INFO - Return code: 0 11:53:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:53: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')]} 11:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53: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')]} 11:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7effb7906f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d410>, '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 0x1e0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', '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 11:53: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', 'jsonschema'] in /builds/slave/test/build 11:53: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 jsonschema 11:53:59 INFO - Using env: {'DISPLAY': ':0', 11:53:59 INFO - 'HOME': '/home/cltbld', 11:53:59 INFO - 'LANG': 'en_US.UTF-8', 11:53:59 INFO - 'LANGUAGE': 'en_US:en', 11:53:59 INFO - 'LOGNAME': 'cltbld', 11:53:59 INFO - 'MAIL': '/var/mail/cltbld', 11:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:59 INFO - 'MOZ_NO_REMOTE': '1', 11:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:59 INFO - 'NO_EM_RESTART': '1', 11:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:59 INFO - 'PWD': '/builds/slave/test', 11:53:59 INFO - 'SHELL': '/bin/bash', 11:53:59 INFO - 'SHLVL': '1', 11:53:59 INFO - 'TERM': 'linux', 11:53:59 INFO - 'TMOUT': '86400', 11:53:59 INFO - 'USER': 'cltbld', 11:53:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', 11:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:59 INFO - '_': '/tools/buildbot/bin/python'} 11:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:59 INFO - Downloading/unpacking jsonschema 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:54:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:54:01 INFO - Downloading/unpacking functools32 (from jsonschema) 11:54:01 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 11:54:01 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 11:54:01 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 11:54:01 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 11:54:01 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 11:54:01 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 11:54:01 INFO - Downloading functools32-3.2.3-2.tar.gz 11:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:54:01 INFO - warning: no files found matching '*.txt' 11:54:01 INFO - no previously-included directories found matching 'build' 11:54:01 INFO - no previously-included directories found matching 'dist' 11:54:01 INFO - no previously-included directories found matching '.git*' 11:54:01 INFO - Installing collected packages: jsonschema, functools32 11:54:01 INFO - Running setup.py install for functools32 11:54:01 INFO - warning: no files found matching '*.txt' 11:54:01 INFO - no previously-included directories found matching 'build' 11:54:01 INFO - no previously-included directories found matching 'dist' 11:54:01 INFO - no previously-included directories found matching '.git*' 11:54:01 INFO - Successfully installed jsonschema functools32 11:54:01 INFO - Cleaning up... 11:54:01 INFO - Return code: 0 11:54:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:54:01 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')]} 11:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:01 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')]} 11:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:01 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 0x7effb7906f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d410>, '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 0x1e0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', '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 11:54:01 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 11:54:01 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 11:54:01 INFO - Using env: {'DISPLAY': ':0', 11:54:01 INFO - 'HOME': '/home/cltbld', 11:54:01 INFO - 'LANG': 'en_US.UTF-8', 11:54:01 INFO - 'LANGUAGE': 'en_US:en', 11:54:01 INFO - 'LOGNAME': 'cltbld', 11:54:01 INFO - 'MAIL': '/var/mail/cltbld', 11:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:01 INFO - 'MOZ_NO_REMOTE': '1', 11:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:01 INFO - 'NO_EM_RESTART': '1', 11:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:01 INFO - 'PWD': '/builds/slave/test', 11:54:01 INFO - 'SHELL': '/bin/bash', 11:54:01 INFO - 'SHLVL': '1', 11:54:01 INFO - 'TERM': 'linux', 11:54:01 INFO - 'TMOUT': '86400', 11:54:01 INFO - 'USER': 'cltbld', 11:54:01 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', 11:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:01 INFO - '_': '/tools/buildbot/bin/python'} 11:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:02 INFO - Downloading/unpacking flake8 11:54: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 11:54: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 11:54: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 11:54: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 11:54: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 11:54: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 11:54:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:54:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:54:03 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 11:54:03 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 11:54:03 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 11:54:03 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 11:54:03 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 11:54:03 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 11:54:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:54:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:54:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:54:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:54:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:54:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:54:04 INFO - no previously-included directories found matching 'docs/_build' 11:54:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:54:04 INFO - Running setup.py install for pep8 11:54:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:54:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:54:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:54:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:54:04 INFO - no previously-included directories found matching 'docs/_build' 11:54:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:54:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:54:04 INFO - Cleaning up... 11:54:04 INFO - Return code: 0 11:54:04 INFO - Running post-action listener: _resource_record_post_action 11:54:04 INFO - Running post-action listener: _start_resource_monitoring 11:54:04 INFO - Starting resource monitoring. 11:54:04 INFO - ##### 11:54:04 INFO - ##### Running install step. 11:54:04 INFO - ##### 11:54:04 INFO - Running pre-action listener: _resource_record_pre_action 11:54:04 INFO - Running main action method: install 11:54:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:54:05 INFO - Reading from file tmpfile_stdout 11:54:05 INFO - Detecting whether we're running mozinstall >=1.0... 11:54:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:54:05 INFO - Reading from file tmpfile_stdout 11:54:05 INFO - Output received: 11:54:05 INFO - Usage: mozinstall [options] installer 11:54:05 INFO - Options: 11:54:05 INFO - -h, --help show this help message and exit 11:54:05 INFO - -d DEST, --destination=DEST 11:54:05 INFO - Directory to install application into. [default: 11:54:05 INFO - "/builds/slave/test"] 11:54:05 INFO - --app=APP Application being installed. [default: firefox] 11:54:05 INFO - mkdir: /builds/slave/test/build/application 11:54:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:54:18 INFO - Reading from file tmpfile_stdout 11:54:18 INFO - Output received: 11:54:18 INFO - /builds/slave/test/build/application/firefox/firefox 11:54:18 INFO - Running post-action listener: _resource_record_post_action 11:54:18 INFO - ##### 11:54:18 INFO - ##### Running run-tests step. 11:54:18 INFO - ##### 11:54:18 INFO - Running pre-action listener: _resource_record_pre_action 11:54:18 INFO - Running main action method: run_tests 11:54:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:54:18 INFO - Python 2.7.3 11:54:18 INFO - Return code: 0 11:54:18 INFO - grabbing minidump binary from tooltool 11:54: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')]} 11:54:18 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 0x1e0d410>, '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 0x1e0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:54:18 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 11:54:18 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 11:54:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:54:18 INFO - Return code: 0 11:54:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:54:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:54:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:54:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:54:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:54:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:54:19 INFO - Return code: 0 11:54:19 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:54:19 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:54:19 INFO - Using env: {'DISPLAY': ':0', 11:54:19 INFO - 'HOME': '/home/cltbld', 11:54:19 INFO - 'LANG': 'en_US.UTF-8', 11:54:19 INFO - 'LANGUAGE': 'en_US:en', 11:54:19 INFO - 'LOGNAME': 'cltbld', 11:54:19 INFO - 'MAIL': '/var/mail/cltbld', 11:54:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:54:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:19 INFO - 'MOZ_NO_REMOTE': '1', 11:54:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:19 INFO - 'NO_EM_RESTART': '1', 11:54:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:19 INFO - 'PWD': '/builds/slave/test', 11:54:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:54:19 INFO - 'SHELL': '/bin/bash', 11:54:19 INFO - 'SHLVL': '1', 11:54:19 INFO - 'TERM': 'linux', 11:54:19 INFO - 'TMOUT': '86400', 11:54:19 INFO - 'USER': 'cltbld', 11:54:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040', 11:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:19 INFO - '_': '/tools/buildbot/bin/python'} 11:54:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:54:19 INFO - mozversion application_buildid: 20160620091522 11:54:19 INFO - mozversion application_changeset: 9798772706750302d87a689cbbf056ae04244f80 11:54:19 INFO - mozversion application_display_name: Firefox 11:54:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:54:19 INFO - mozversion application_name: Firefox 11:54:19 INFO - mozversion application_remotingname: firefox 11:54:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:54:19 INFO - mozversion application_vendor: Mozilla 11:54:19 INFO - mozversion application_version: 48.0 11:54:19 INFO - mozversion platform_buildid: 20160620091522 11:54:19 INFO - mozversion platform_changeset: 9798772706750302d87a689cbbf056ae04244f80 11:54:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:54:19 INFO - mozversion platform_version: 48.0 11:54:19 INFO - using testdate: 1466448859 11:54:19 INFO - actual date: 1466448859 11:54:19 INFO - starting webserver on 'localhost:33235' 11:54:19 INFO - SUITE-START | Running 2 tests 11:54:19 INFO - TEST-START | dromaeo_css 11:54:19 INFO - operating with platform_type : linux_ 11:54:19 INFO - Initialising browser for dromaeo_css test... 11:54:19 INFO - TEST-INFO | started process 10786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoRGe9S/profile http://localhost:33235/getInfo.html) 11:54:23 INFO - PROCESS | 10786 | __metrics Screen width/height:1600/1200 11:54:23 INFO - PROCESS | 10786 | colorDepth:24 11:54:23 INFO - PROCESS | 10786 | Browser inner width/height: 1024/697 11:54:23 INFO - PROCESS | 10786 | __metrics 11:54:24 ERROR - PROCESS | 10786 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:54:25 INFO - TEST-INFO | 10786: exit 0 11:54:25 INFO - Browser initialized. 11:54:25 INFO - Running cycle 1/1 for dromaeo_css test... 11:54:25 INFO - TEST-INFO | started process 10873 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoRGe9S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:54:37 INFO - PROCESS | 10873 | RSS: Main: 140951552 11:54:37 INFO - PROCESS | 10873 | 11:55:28 INFO - PROCESS | 10873 | 1466448928715 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] 11:57:35 INFO - PROCESS | 10873 | Cycle 1(1): loaded http://localhost:33235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33235/tests/dromaeo/cssquery-ext.html) 11:57:36 INFO - PROCESS | 10873 | RSS: Main: 238952448 11:57:36 INFO - PROCESS | 10873 | 12:00:38 INFO - PROCESS | 10873 | Cycle 1(1): loaded http://localhost:33235/tests/dromaeo/cssquery-ext.html (next: http://localhost:33235/tests/dromaeo/cssquery-jquery.html) 12:00:39 INFO - PROCESS | 10873 | RSS: Main: 219475968 12:00:39 INFO - PROCESS | 10873 | 12:03:41 INFO - PROCESS | 10873 | Cycle 1(1): loaded http://localhost:33235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33235/tests/dromaeo/cssquery-mootools.html) 12:03:41 INFO - PROCESS | 10873 | RSS: Main: 215941120 12:03:41 INFO - PROCESS | 10873 | 12:06:43 INFO - PROCESS | 10873 | Cycle 1(1): loaded http://localhost:33235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33235/tests/dromaeo/cssquery-prototype.html) 12:06:44 INFO - PROCESS | 10873 | RSS: Main: 214507520 12:06:44 INFO - PROCESS | 10873 | 12:09:46 INFO - PROCESS | 10873 | Cycle 1(1): loaded http://localhost:33235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33235/tests/dromaeo/cssquery-yui.html) 12:09:47 INFO - PROCESS | 10873 | RSS: Main: 209805312 12:09:47 INFO - PROCESS | 10873 | 12:12:49 INFO - PROCESS | 10873 | Cycle 1(1): loaded http://localhost:33235/tests/dromaeo/cssquery-yui.html (next: http://localhost:33235/tests/dromaeo/cssquery-dojo.html) 12:12:49 INFO - PROCESS | 10873 | RSS: Main: 256626688 12:12:49 INFO - PROCESS | 10873 | 12:12:49 INFO - PROCESS | 10873 | __start_tp_report 12:12:49 INFO - PROCESS | 10873 | _x_x_mozilla_page_load 12:12:49 INFO - PROCESS | 10873 | _x_x_mozilla_page_load_details 12:12:49 INFO - PROCESS | 10873 | |i|pagename|runs| 12:12:49 INFO - PROCESS | 10873 | |0;dojo.html;3279.4752839545677;3378.881739139129;3391.1013581400935;3408.6080100788417;3432.5537680101584;5478.808241711541;5481.671099734014;5483.725813709313;5488.451154884509;5501.284832971718;5470.5350045246205;5495.53287970522;5496.5053145216925;5506.559475241981;5536.058869992101;4933.580645645106;4939.703617782944;4951.257311403291;5026.798928042892;5083.18669012958;4927.1377508935975;4961.8511444656715;5006.699598024112;5026.29631851541;5057.59539236862;4987.875303117415;5031.295618613397;5042.344495215617;5043.6721613095215;5048.621353398491;4935.728534930578;4993.425756038029;5005.174146265862;5006.324146240266;5014.899702005958;4892.902141957141;4905.975470122662;4942.629302802268;4947.233178857283;4971.055499455092;5347.6256662033675;5348.117560602496;5369.382521010056;5370.758315875756;5396.730163491809;5799.942000579982;5833.854153646151;5847.06446968483;5847.590668653153;5847.678377689225;5789.65262084272;5860.3260625027815;5909.349971503131;5948;5952.1964534787685;5515.227868098469;5556.388797232301;5560.193771903051;5565.332160140769;5566.86082847928;5944.554158438134;6038.637681739022;6049.364816694272;6095.359987201368;6097.664628445389;5746.080627099644;5817.0983497557945;5819.53443724501;5852.268466441695;5853.0635098384055;5869.442402971711;5879.735411906475;5887.528997680175;5892.204552385373;5893.233879595625;5779.653220806681;5833.591648584643;5851.970740146272;5863.472287494061;5864.970675146597;5806.187133801272;5855.063189889597;5869.383714709894;5886.440788125121;5896.469317761422;4477.977610111929;4504.6396288296855;4508.81964721414;4511.413516242867;4535.455745310518;3949.743266687656;4008.0581063450068;4051.2707712611423;4057.046594050396;4087.5912408758886;5617.943820561742;5631.605787594829;5644.520215781622;5662.716864156776;5666.065099258659;5865.912011319833;5867.325257595431;5869.735861886225;5885.293764748258;5890.852728681732;5482.972585137129;5620.578456615688;5637.746301416446;5647.519960803295;5677.37548869624;5092.745362731848;5095.668781529189;5096.923546146811;5102.030614183293;5123.180291153398;6103.42017508336;6112.969435152796;6115.0215965446205;6120.60216085953;6121.540884433685;5759.856003599776;5862.648241105548;5885.17607534954;5894.587378883437;5921.171036055042;6074.51403887679;6077.088436734349;6079.483243924316;6111.358307377662;6116.204893363834;5744.684042377709;5773.364929857628;5785.768569257182;5789.739461724148;5793.507551858139;5761.884762304814;5805.274340707411;5867.882642347044;5870.559708022;5915.497182739516;5762.164486149569;5767.509761670305;5769.798057067983;5775.8556036099435;5784.566157538117;5700.429957004267;5749.166370876116;5756.222909907109;5760.769569217352;5768.913466298093;5539.529140022982;5592.189132575835;5641.069223578063;5658.236138121301;5682.516986056232;5751.252337196138;5769.769209231584;5784.016717158009;5787;5794.3626201117;5655.4910058094965;5666.15007748841;5667.376588575171;5668.206451096932;5697.686627235542 12:12:49 INFO - PROCESS | 10873 | |1;ext.html;611.5871786544085;661.5468404143162;674.4469534981317;675.932406759324;676.8883134282846;36456.088597785034;37231.255374892484;39745.20509589806;40851.795741021255;40933.18133637326;45830.31254531185;46506.53493465064;46602.30096548554;46649.30026049612;46677;8170.836583268331;9029.683961061348;9270.582823772946;9275.536223188847;10349.430781307025;10815;10990.17573681973;10998.395088270141;11002.174836887265;11012.669619911416;10989.395583242958;11082.833757493603;11083.778324433506;11086.889131108706;11097.278676885977;10891.945540272287;10939.234253602252;10941.452927353681;10989.175811814066;10991.450427478594;10969.670909872717;11059.944700276446;11071.833922491169;11090.445477726082;11107.888921110767;43782.12435751267;43983.56016439859;44366;44371.77814110909;44441.111177776584;3775.339315619756;3793.2982398256136;3877.3214687429586;4169.312063509517;4493.887652808673;33058.3388332232;33092.83453582741;33128.3374332512;33198;33446;4532.750698711569;4583.312503124558;4613.308003799423;4662.207424737802;4669.7665116744365;311255;311867;312345;312593;313527;60187.69906150441;60911;60915.39084609186;60915.39084609186;60932;65245.347546523924;71986;73715;73717;73753.26246737571;18537.81462185388;18831.62336753257;18831.90584047071;18879;18885.716714249298;13938.93030534841;14983.400663973536;15169.165695886612;15468.92265538665;15525.922370388076;19535.70126685945;20357.796422035888;20358.796412035987;20397.49006274855;20533.178672853217;7197.568145911262;7397.630118494054;7403.14863790671;7434.888476672854;7503.124218945263;1052.1004541117388;1070.4380200394855;1121.484117306032;1141.6974501756874;1154.6132045764764;32740;33879.66120338815;34185.31629367399;34285;34381.14047148841;1195.4261954262004;1196.7486827766093;1244.993775031119;1273.9490420383265;1279.9424025918856;17198.928814101124;17599.296028158988;17632.647347052985;17785.911070444825;17852.91073544624;488482;488581;491802;493909;494146;62529.374706253264;63222.051669224995;63238.36761632417;63290;63304.366956329846;1387.070662656023;1480.3930388540646;1482.740520408924;1482.8813694904381;1587.428525730736;30491.847540763043;31184.844075779474;32250.516242256854;32266.19334516562;32888.50667239945;45492;45618.771906141585;45978.54021459876;45997;46017;309100;311397;312011;312276;312898;27282;31085.378292433572;31719.841400792848;31738.523922140725;31760.68239317577;46008;48749;49073;49758.50241497539;50123;39683.60316396799;40456;40628.59371406248;40801.38797918093;41356.58643413527;39809.80095099506;40026.79986600048;40218;40332;41247.58752412438;41514.1697166049;41932;42443;42820.78589607032;42871.7856410716;34871.8615324622;36709;37482.62517374791;37819.243615126994;38404;28745.281367965967;28773.56839647449;29078.41843163167;29086.85456572788;29112.27219319534 12:12:49 INFO - PROCESS | 10873 | |2;jquery.html;428.96353809926154;431.88770919560903;434.0358940794945;437.2108344438289;439.61533658049206;18468;18897.90551047246;19082.61834763304;19167.520811979706;19840.702389464168;18594.721079183822;18911.148998295077;19983.500412489695;19996;20023.299184528507;5696.316442026942;5705.77176912923;5914.704264786765;5918.556108291874;5918.704064796743;4369.431973843396;5817.738201780909;5870.559708021894;6147.784827531037;6464.095026696266;6420.7752728654505;6468.126802881621;6472.352764723537;6476.838079048014;6482.254540727806;5996.340402555716;6302.779402720928;6312.873742525147;6313.463355614732;6444.677766111676;3862.4206369044587;4426.690131690783;5661.46216109469;5682.829515114553;5695.231143795576;13994.090384125;14147.221902795445;14178.078424902451;14230.146191228456;20339.694904576445;2488.925332240036;2573.2630474429684;2653.4162484253434;2689.542777727791;3099.7985130966417;9744.366616169926;10141;10254.589816407335;10275.588976440933;10453;1969.241841890868;2010.6380851446734;2043.2914260616933;2148.409187473457;2166.9783302166934;75689.24310756876;76590.61704691441;77016;77035.22964770392;81982.6609502036;11259.268147570545;11420.600278990361;11468;11651.485306910217;11884.88115118855;16282.837171628133;16490;16500.75248871268;16528.586785330222;16538.338466461446;8943.3739638226;9011.774705632411;9095.363324567217;9136;9193.080691930754;8870.334724895529;8884.8667269991;8894.42186257891;9017.143371379709;9034;5017.949820501822;5053.898922021539;5087.720175390315;5091.770870310771;5152.639315247971;1825.361123606727;1973.289615738333;2013.3758534854242;2088.1229883448987;2121.9257325993517;1012.7721262715977;1031.8039572481205;1053.2364036073939;1079.2893264176212;1080.1197024425069;17811.554711132325;18034.188461519;18195.27218911255;18470.445886623424;18914;1010.7372083258406;1048.4810019040624;1056.4823236614156;1097.6103483263487;1147.8966892979504;10283.691489255334;10652.414117223627;11170.218084734153;11183.944080279547;11271;443170;465110;468562;470738;470922;96679;99645;99770;100427.49786251022;101649.49175254225;1119.2109562758399;1138.4706111658118;1172.5778719660916;1178.3224645828682;1195.7010747313172;17216.827831721523;17246.741298880275;17657.735133972743;17881.46355609334;18057.909710451364;38321;38731.6126838728;38916.41625375678;41049.589504105774;41184.1763164741;51229.23156152586;54341;57299;57740.422595775184;57975.13037304528;9163.633454661738;9280.535973201448;9332.440053596534;9449.29130315243;9599.376040557341;11983.34091624969;13276.867231327564;13304.334783260605;13474.730505390033;13844.30778461093;11612;11831.230969986924;11975.28148311104;12126.393680316125;12321.93839030799;11484.425778711198;11622.244554104294;11749.588764393206;12021.639350819489;12076.335801531;12150.878491214975;12407.25556466615;12419.254844709347;12739.936300318439;12784.296863672587;8957.820843582962;9089.227415669742;9224.538773061186;9279.443233406017;9565.963732172786;11958.940205299266;12031.578894738643;12172;12399.814002790146;12570.685732856751 12:12:49 INFO - PROCESS | 10873 | |3;mootools.html;1348.2315080404173;1494.4545240987043;1515.272669118823;1686.2327640923381;1852.3053854804448;8197.75406737798;8392.916070839297;8401.621927013291;8416.91583084169;8421.831563368729;8178.100408955011;8333.416660833744;8339.082700902896;8343.08226095129;8350.95824520878;2330.813534917211;2345.566070277004;2346.1671106757112;2352.541254455382;2352.9529409411803;2380.143148466551;2391.689080419543;2438.7073551173885;2460.507898420314;2467.148833652387;2331.5453486570127;2340.262817212581;2348.8825558722083;2379.8572085674914;2400.543896659629;2314.409825494505;2319.2926157521947;2386.3795413192606;2401.747816479262;2402.4354276744953;2388.8088952883727;2451.644511545816;2462.495188486356;2469.1975108089764;2469.790067844235;7122.821929451753;8095.028596568391;8576.571171441403;8629.741107766777;8637;5203.895922081537;5277.313949186581;5278.841634750964;5317.813876514303;5330.440303768088;3500.3699334119847;3515.859365625372;3592.0121966459174;3664.8167591620577;3694.131879008431;1235.2773627427966;1241.944112514939;1252.8621851596408;1263.3367482071894;1287.671643730852;11313.943430282878;11661.24201926872;11680.707982300426;11693.941530292293;11739.354335511543;4540.841070562515;4627.745473998963;4673.836415725434;4715.504871988392;4719.646026548023;10091.545880435398;10097.899021009844;10098.242631802645;10104.797904041878;10119.595216191417;5320.813771517978;5345.438728933484;5349.919751203735;5352.170413585901;5356.276902618097;4901.803927842846;4902.1911384621135;4905.533974272438;4910.680805747615;4918.680285781485;3812.3709587917683;3886.8833934981994;3901.941470877939;3904.7657140571655;3923.4507168996365;1173.9354335511457;1173.9647810565696;1177.087756988341;1191.7020744813797;1205.7769312677183;970.3304719743495;984.3945973226414;1005.1506477026901;1012.1618662791867;1017.6692574913183;5865.826834633005;5896.321922978912;5950.464458198783;6035.39646035393;6056.788012419544;930.7254359963827;1009.5255230041869;1019.8062368150028;1031.4584842957358;1042.921780866438;3849.1339448624394;3978.5822488638855;3986.647972497613;4016.59834016596;4027.8791636250958;10492.842607360895;10707.73230669224;10821.621243256448;10830.133589312836;10841.024307812335;10605.681829545127;10666.573337066586;10676.62631807883;10677.626283080055;10684.57261709523;8075.596220188967;8131.18688131194;8214.219649133442;8225.136360682161;8227.053888802864;5658.85852853682;5660.575456840671;5677.347105082803;5690.77236910519;5793.131030345482;9299.67451139207;9335.533223338942;9461.716148515556;9481.57332920034;9482.57328420209;9372.718818435458;9459.479728614991;9614.615415383307;9649.372790768577;9708.951455242679;7837.6081195941115;7872.881906771518;7960.084590272193;7999.160088190889;8005.3995950305125;8056.033276006917;8070.596470176585;8131;8215.383846211678;8227.177282271725;7138.571685698875;7331.560106393634;7404.851902962018;7421.443391745533;7437.553746775211;7567.129780075362;7604.467687261838;7678.500897441649;7736.226377362219;7790.88313675284;6848.075509806113;6976.651167441709;6992.755253566101;7156.785296441115;7187.604681742345;4599.724016559017;4670;4804.42346918372;4812.085703716282;4928.310036594808;4720.716756994591;4720.976395118139;4721.315409265569;4787.234042553175;4831.4202295724735 12:12:49 INFO - PROCESS | 10873 | |4;prototype.html;361.8679182098533;364.2787281183259;366.06105339803395;367.25447341895955;367.968722658574;6077.848053798657;6086.634801911889;6086.8478288042825;6128.3258841527395;6136.079588061793;5922.763089476416;6009.4591486766185;6077.939220607793;6085.178500902377;6110.908336374947;4689.226277664181;4729.976350118244;4734.763261836912;4753.786079626408;4764.190087685102;4745.525447455261;4753.239481682931;4760.214564596838;4832.323474713543;4837.6129909607325;4549.522300158485;4786.688865223767;4788.0663270662235;4794.256890182028;4795.352627395292;4637.142128706183;4760.190767569521;4795.904081918342;4797.472278049412;4815.975920120412;4239.936400953989;4241.809118589671;4244.469441319835;4245.745255284662;4247.5752424757275;6054.69726513677;6057.818265452043;6068.757249710006;6078.057901025348;6078.422549857756;5648.576356773217;5653.095504719226;5653.745581448845;5656.519195868356;5669.9433005669825;6323.462505687022;6648.235452922928;6651.23510796255;6651.80044598658;6653.667316634197;4513.097380523908;4544.068465964469;4545.318202269653;4545.840895568639;4550.7497087660495;6875.312468753134;6952.331440454254;6959.4432445404755;6962.582245065312;6967.8606427871155;4725.5983241424865;4746.833860814855;4748.19280722278;4751.572358487752;4753.548412900769;4793.065352256276;4815.566599006036;4817.494163112893;4817.542333478314;4818.036392721469;5529;5555.916661250085;5556.277683901148;5558.249636299129;5558.416366281483;6465.612063276219;6699.43054840344;6702.932970670328;6707.0610114584;6710.597364158166;1657.2376706714806;1688.1643586424552;1692.3061544766833;1694.3900195929455;1697.4313604942236;1045.268312181476;1078.2398409121706;1094.2996482251365;1123.0678536814423;1127.8702949160788;6348.873022539616;6452.193475815523;6479.5788273762055;6486.4486518646445;6491.221053473613;6807;6820.931790682129;6831.385175334244;6838.658067096725;6840.48696347766;6446.967765161145;6462.935370646233;6464.256610489854;6468.773592924225;6470.38531339522;3643.890683279506;3675.9264814703556;3686.7419280650097;3686.9262614747554;3688.5389326334207;7001.299870012958;7290.125184977731;7290.8177295566975;7312.96343518279;7327.303906128909;7058.505904586629;7104.7158113675905;7105.32499412555;7106.502544821917;7111.324424179695;7276.054112965387;7285.672144753499;7287.781366559012;7290.890636640454;7304.160021597372;6799.93200067993;6926.134233220848;6930.826729331807;6936;6943.618101004493;6794.694238759366;6795.116634837439;6804.21751498584;6805.557638753465;6828.795136145924;7228.855422891618;7269.636518173965;7277.745278915212;7278.599677017814;7286.234945330876;4721.787519561559;4754.334393185026;4755.548222918817;4755.667103302736;4760.761961901821;6889.862202756017;6891.207511136284;6900.275471075464;6900.551464154814;6953.75661851853;6555.4427873631275;6691.76578819739;6697.2633010367845;6706.8993965089585;6708.731650733916;6649.833754155991;6664.366885145903;6673.499487538551;6682.599044057372;6697.0958920547055;6559.245686745894;6570.178727659043;6576.671166441563;6576.8355791103695;6581.407673309425;6752.898706519308;6753.358430949052;6756.391924726799;6816.522843400914;6840.623765692736;6322.905156422566;6409.615423074631;6416.454601358937;6557.442617377576;6594.604323740591 12:12:49 INFO - PROCESS | 10873 | |5;yui.html;768.6925229908039;772.2354868680005;839.3998291221775;880.4145243413129;898.8471959766841;14013.439462421504;14340.498082567112;14346.139231646108;14390.496332628372;14391.42434302628;14217.928910355433;14326.283685815693;14338.13971161731;14506.347214375352;14507.27463626817;724.3915111306502;880.4013270975734;883.147762409275;890.2521881619471;905.5743800413795;892.0722448653393;896.3814967672286;904.398574947659;904.900460949295;905.4386280506095;936.7330310861406;947.3415975896754;949.2500924269818;949.952502374882;950.9286803489731;767;909.4634165842152;925.5048549026305;925.6297481007583;928.3687092776909;687.3298533929429;689.0422312984905;689.6172624193571;690.4786885901162;691.0360047733434;14099.577012689635;14150.929245353811;14207.78688319676;14235.145891246455;14284;13092.607221783363;13230.404631791593;13530.25583592902;13717.519886804013;14702.411903523845;10804.243702940797;10964.451777411097;11131.777364452746;11352.602658906899;11596.76806463866;3955.7230993830444;3957.0700885291935;4004.2191772604356;4006.419069234945;4043.636072753437;52738;53275.93448131054;53315.334233288566;53975.73012134954;54007.45992540103;10457.477126143662;10814.945925270324;11737.941310293394;11864.288212661666;11994.220375675553;20082.39752807418;20245.392638220583;20250.088746006466;20554.38336849897;20567.07448164836;8594.5702714864;8848.690295839615;8878.245349145265;8890.644374225089;8980.652902064612;4783.856484305476;4821.156297647897;4821.5178482152205;4854.902901941941;4871.074495845778;3478.913027174341;3502.1069627245397;3558.893233203008;3565.750397472204;3566.964330356715;587.9470847623735;663.7146027208347;690.6167077272062;699.0841996983967;700.1982729774481;732.3372348025046;750.8911207874828;763.9618019099023;778.9561986937531;823.8228780812034;9237.399569027992;9297.426810093068;9350.438973661467;9510.952445237868;9624;714.7819914925998;776.8096816280048;783.7100272899064;793.8234014789057;794.5550491724653;4414.404055452537;4418.911621767546;4496.482904465963;4611.193041217841;4641.419822522184;59391.40608593945;62087;62211;62452.375476245565;62599.68700156561;54733;54741.452585473635;55370.72314638401;55723;56801;48850;48893.266601001014;48946.26580601294;49989;50016;9057.81884362296;9124.31567632417;9156.175944165057;9176.44941303524;9200.907990920005;36837.44743828898;37673.246535068596;38248.61751382562;38651.806740966116;39696.801515992236;43833;43861.34207986819;46210.537894620626;47120.29319560278;47562.28656570085;10774.934819030068;10793.56825726962;11201.159913006393;11230.94384528072;11429.199956003;10788.892111078789;10985.725356866142;11095.056920161876;11271.098312134845;11285.661430157108;11510.712232194262;12450.937745311216;12803.80794288105;13232.603021909357;13684.247366394944;12547.623571292876;12710.809337859755;12832.101752877208;13280.335983200994;13456.932715336361;11877.524899003944;11911.940440297743;11972;12170.14808963364;12314.81527777102;10913.23607347478;11031;11036.889631103586;11128.721781955192;11318;10965.396903170084;10989.835152472559;11167.497462614365;11200.775984480428;11417.828732568853 12:12:49 INFO - PROCESS | 10873 | __end_tp_report 12:12:49 INFO - PROCESS | 10873 | __start_cc_report 12:12:49 INFO - PROCESS | 10873 | _x_x_mozilla_cycle_collect,819 12:12:49 INFO - PROCESS | 10873 | __end_cc_report 12:12:49 INFO - PROCESS | 10873 | __startTimestamp1466449969889__endTimestamp 12:12:49 INFO - PROCESS | 10873 | 12:12:49 INFO - PROCESS | 10873 | ------- Summary: start ------- 12:12:49 INFO - PROCESS | 10873 | Number of tests: 6 12:12:49 INFO - PROCESS | 10873 | 12:12:49 INFO - PROCESS | 10873 | [#0] dojo.html Cycles:165 Average:5468.32 Median:5677.38 stddev:597.18 (10.5%) stddev-sans-first:573.79 12:12:49 INFO - PROCESS | 10873 | Values: 3279.5 3378.9 3391.1 3408.6 3432.6 5478.8 5481.7 5483.7 5488.5 5501.3 5470.5 5495.5 5496.5 5506.6 5536.1 4933.6 4939.7 4951.3 5026.8 5083.2 4927.1 4961.9 5006.7 5026.3 5057.6 4987.9 5031.3 5042.3 5043.7 5048.6 4935.7 4993.4 5005.2 5006.3 5014.9 4892.9 4906.0 4942.6 4947.2 4971.1 5347.6 5348.1 5369.4 5370.8 5396.7 5799.9 5833.9 5847.1 5847.6 5847.7 5789.7 5860.3 5909.3 5948.0 5952.2 5515.2 5556.4 5560.2 5565.3 5566.9 5944.6 6038.6 6049.4 6095.4 6097.7 5746.1 5817.1 5819.5 5852.3 5853.1 5869.4 5879.7 5887.5 5892.2 5893.2 5779.7 5833.6 5852.0 5863.5 5865.0 5806.2 5855.1 5869.4 5886.4 5896.5 4478.0 4504.6 4508.8 4511.4 4535.5 3949.7 4008.1 4051.3 4057.0 4087.6 5617.9 5631.6 5644.5 5662.7 5666.1 5865.9 5867.3 5869.7 5885.3 5890.9 5483.0 5620.6 5637.7 5647.5 5677.4 5092.7 5095.7 5096.9 5102.0 5123.2 6103.4 6113.0 6115.0 6120.6 6121.5 5759.9 5862.6 5885.2 5894.6 5921.2 6074.5 6077.1 6079.5 6111.4 6116.2 5744.7 5773.4 5785.8 5789.7 5793.5 5761.9 5805.3 5867.9 5870.6 5915.5 5762.2 5767.5 5769.8 5775.9 5784.6 5700.4 5749.2 5756.2 5760.8 5768.9 5539.5 5592.2 5641.1 5658.2 5682.5 5751.3 5769.8 5784.0 5787.0 5794.4 5655.5 5666.2 5667.4 5668.2 5697.7 12:12:49 INFO - PROCESS | 10873 | 12:12:49 INFO - PROCESS | 10873 | [#1] ext.html Cycles:180 Average:55537.52 Median:34626.50 stddev:100476.87 (290.2%) stddev-sans-first:100674.11 12:12:49 INFO - PROCESS | 10873 | Values: 611.6 661.5 674.4 675.9 676.9 36456.1 37231.3 39745.2 40851.8 40933.2 45830.3 46506.5 46602.3 46649.3 46677.0 8170.8 9029.7 9270.6 9275.5 10349.4 10815.0 10990.2 10998.4 11002.2 11012.7 10989.4 11082.8 11083.8 11086.9 11097.3 10891.9 10939.2 10941.5 10989.2 10991.5 10969.7 11059.9 11071.8 11090.4 11107.9 43782.1 43983.6 44366.0 44371.8 44441.1 3775.3 3793.3 3877.3 4169.3 4493.9 33058.3 33092.8 33128.3 33198.0 33446.0 4532.8 4583.3 4613.3 4662.2 4669.8 311255.0 311867.0 312345.0 312593.0 313527.0 60187.7 60911.0 60915.4 60915.4 60932.0 65245.3 71986.0 73715.0 73717.0 73753.3 18537.8 18831.6 18831.9 18879.0 18885.7 13938.9 14983.4 15169.2 15468.9 15525.9 19535.7 20357.8 20358.8 20397.5 20533.2 7197.6 7397.6 7403.1 7434.9 7503.1 1052.1 1070.4 1121.5 1141.7 1154.6 32740.0 33879.7 34185.3 34285.0 34381.1 1195.4 1196.7 1245.0 1273.9 1279.9 17198.9 17599.3 17632.6 17785.9 17852.9 488482.0 488581.0 491802.0 493909.0 494146.0 62529.4 63222.1 63238.4 63290.0 63304.4 1387.1 1480.4 1482.7 1482.9 1587.4 30491.8 31184.8 32250.5 32266.2 32888.5 45492.0 45618.8 45978.5 45997.0 46017.0 309100.0 311397.0 312011.0 312276.0 312898.0 27282.0 31085.4 31719.8 31738.5 31760.7 46008.0 48749.0 49073.0 49758.5 50123.0 39683.6 40456.0 40628.6 40801.4 41356.6 39809.8 40026.8 40218.0 40332.0 41247.6 41514.2 41932.0 42443.0 42820.8 42871.8 34871.9 36709.0 37482.6 37819.2 38404.0 28745.3 28773.6 29078.4 29086.9 29112.3 12:12:49 INFO - PROCESS | 10873 | 12:12:49 INFO - PROCESS | 10873 | [#2] jquery.html Cycles:180 Average:28292.44 Median:11191.49 stddev:76687.50 (685.2%) stddev-sans-first:76874.09 12:12:49 INFO - PROCESS | 10873 | Values: 429.0 431.9 434.0 437.2 439.6 18468.0 18897.9 19082.6 19167.5 19840.7 18594.7 18911.1 19983.5 19996.0 20023.3 5696.3 5705.8 5914.7 5918.6 5918.7 4369.4 5817.7 5870.6 6147.8 6464.1 6420.8 6468.1 6472.4 6476.8 6482.3 5996.3 6302.8 6312.9 6313.5 6444.7 3862.4 4426.7 5661.5 5682.8 5695.2 13994.1 14147.2 14178.1 14230.1 20339.7 2488.9 2573.3 2653.4 2689.5 3099.8 9744.4 10141.0 10254.6 10275.6 10453.0 1969.2 2010.6 2043.3 2148.4 2167.0 75689.2 76590.6 77016.0 77035.2 81982.7 11259.3 11420.6 11468.0 11651.5 11884.9 16282.8 16490.0 16500.8 16528.6 16538.3 8943.4 9011.8 9095.4 9136.0 9193.1 8870.3 8884.9 8894.4 9017.1 9034.0 5017.9 5053.9 5087.7 5091.8 5152.6 1825.4 1973.3 2013.4 2088.1 2121.9 1012.8 1031.8 1053.2 1079.3 1080.1 17811.6 18034.2 18195.3 18470.4 18914.0 1010.7 1048.5 1056.5 1097.6 1147.9 10283.7 10652.4 11170.2 11183.9 11271.0 443170.0 465110.0 468562.0 470738.0 470922.0 96679.0 99645.0 99770.0 100427.5 101649.5 1119.2 1138.5 1172.6 1178.3 1195.7 17216.8 17246.7 17657.7 17881.5 18057.9 38321.0 38731.6 38916.4 41049.6 41184.2 51229.2 54341.0 57299.0 57740.4 57975.1 9163.6 9280.5 9332.4 9449.3 9599.4 11983.3 13276.9 13304.3 13474.7 13844.3 11612.0 11831.2 11975.3 12126.4 12321.9 11484.4 11622.2 11749.6 12021.6 12076.3 12150.9 12407.3 12419.3 12739.9 12784.3 8957.8 9089.2 9224.5 9279.4 9566.0 11958.9 12031.6 12172.0 12399.8 12570.7 12:12:49 INFO - PROCESS | 10873 | 12:12:49 INFO - PROCESS | 10873 | [#3] mootools.html Cycles:180 Average:5668.75 Median:4721.15 stddev:3126.43 (66.2%) stddev-sans-first:3118.34 12:12:49 INFO - PROCESS | 10873 | Values: 1348.2 1494.5 1515.3 1686.2 1852.3 8197.8 8392.9 8401.6 8416.9 8421.8 8178.1 8333.4 8339.1 8343.1 8351.0 2330.8 2345.6 2346.2 2352.5 2353.0 2380.1 2391.7 2438.7 2460.5 2467.1 2331.5 2340.3 2348.9 2379.9 2400.5 2314.4 2319.3 2386.4 2401.7 2402.4 2388.8 2451.6 2462.5 2469.2 2469.8 7122.8 8095.0 8576.6 8629.7 8637.0 5203.9 5277.3 5278.8 5317.8 5330.4 3500.4 3515.9 3592.0 3664.8 3694.1 1235.3 1241.9 1252.9 1263.3 1287.7 11313.9 11661.2 11680.7 11693.9 11739.4 4540.8 4627.7 4673.8 4715.5 4719.6 10091.5 10097.9 10098.2 10104.8 10119.6 5320.8 5345.4 5349.9 5352.2 5356.3 4901.8 4902.2 4905.5 4910.7 4918.7 3812.4 3886.9 3901.9 3904.8 3923.5 1173.9 1174.0 1177.1 1191.7 1205.8 970.3 984.4 1005.2 1012.2 1017.7 5865.8 5896.3 5950.5 6035.4 6056.8 930.7 1009.5 1019.8 1031.5 1042.9 3849.1 3978.6 3986.6 4016.6 4027.9 10492.8 10707.7 10821.6 10830.1 10841.0 10605.7 10666.6 10676.6 10677.6 10684.6 8075.6 8131.2 8214.2 8225.1 8227.1 5658.9 5660.6 5677.3 5690.8 5793.1 9299.7 9335.5 9461.7 9481.6 9482.6 9372.7 9459.5 9614.6 9649.4 9709.0 7837.6 7872.9 7960.1 7999.2 8005.4 8056.0 8070.6 8131.0 8215.4 8227.2 7138.6 7331.6 7404.9 7421.4 7437.6 7567.1 7604.5 7678.5 7736.2 7790.9 6848.1 6976.7 6992.8 7156.8 7187.6 4599.7 4670.0 4804.4 4812.1 4928.3 4720.7 4721.0 4721.3 4787.2 4831.4 12:12:49 INFO - PROCESS | 10873 | 12:12:49 INFO - PROCESS | 10873 | [#4] prototype.html Cycles:180 Average:5582.40 Median:6323.18 stddev:1696.84 (26.8%) stddev-sans-first:1655.74 12:12:49 INFO - PROCESS | 10873 | Values: 361.9 364.3 366.1 367.3 368.0 6077.8 6086.6 6086.8 6128.3 6136.1 5922.8 6009.5 6077.9 6085.2 6110.9 4689.2 4730.0 4734.8 4753.8 4764.2 4745.5 4753.2 4760.2 4832.3 4837.6 4549.5 4786.7 4788.1 4794.3 4795.4 4637.1 4760.2 4795.9 4797.5 4816.0 4239.9 4241.8 4244.5 4245.7 4247.6 6054.7 6057.8 6068.8 6078.1 6078.4 5648.6 5653.1 5653.7 5656.5 5669.9 6323.5 6648.2 6651.2 6651.8 6653.7 4513.1 4544.1 4545.3 4545.8 4550.7 6875.3 6952.3 6959.4 6962.6 6967.9 4725.6 4746.8 4748.2 4751.6 4753.5 4793.1 4815.6 4817.5 4817.5 4818.0 5529.0 5555.9 5556.3 5558.2 5558.4 6465.6 6699.4 6702.9 6707.1 6710.6 1657.2 1688.2 1692.3 1694.4 1697.4 1045.3 1078.2 1094.3 1123.1 1127.9 6348.9 6452.2 6479.6 6486.4 6491.2 6807.0 6820.9 6831.4 6838.7 6840.5 6447.0 6462.9 6464.3 6468.8 6470.4 3643.9 3675.9 3686.7 3686.9 3688.5 7001.3 7290.1 7290.8 7313.0 7327.3 7058.5 7104.7 7105.3 7106.5 7111.3 7276.1 7285.7 7287.8 7290.9 7304.2 6799.9 6926.1 6930.8 6936.0 6943.6 6794.7 6795.1 6804.2 6805.6 6828.8 7228.9 7269.6 7277.7 7278.6 7286.2 4721.8 4754.3 4755.5 4755.7 4760.8 6889.9 6891.2 6900.3 6900.6 6953.8 6555.4 6691.8 6697.3 6706.9 6708.7 6649.8 6664.4 6673.5 6682.6 6697.1 6559.2 6570.2 6576.7 6576.8 6581.4 6752.9 6753.4 6756.4 6816.5 6840.6 6322.9 6409.6 6416.5 6557.4 6594.6 12:12:49 INFO - PROCESS | 10873 | 12:12:49 INFO - PROCESS | 10873 | [#5] yui.html Cycles:180 Average:14919.91 Median:25410.87 stddev:17118.97 (67.4%) stddev-sans-first:17134.01 12:12:49 INFO - PROCESS | 10873 | Values: 768.7 772.2 839.4 880.4 898.8 14013.4 14340.5 14346.1 14390.5 14391.4 14217.9 14326.3 14338.1 14506.3 14507.3 724.4 880.4 883.1 890.3 905.6 892.1 896.4 904.4 904.9 905.4 936.7 947.3 949.3 950.0 950.9 767.0 909.5 925.5 925.6 928.4 687.3 689.0 689.6 690.5 691.0 14099.6 14150.9 14207.8 14235.1 14284.0 13092.6 13230.4 13530.3 13717.5 14702.4 10804.2 10964.5 11131.8 11352.6 11596.8 3955.7 3957.1 4004.2 4006.4 4043.6 52738.0 53275.9 53315.3 53975.7 54007.5 10457.5 10814.9 11737.9 11864.3 11994.2 20082.4 20245.4 20250.1 20554.4 20567.1 8594.6 8848.7 8878.2 8890.6 8980.7 4783.9 4821.2 4821.5 4854.9 4871.1 3478.9 3502.1 3558.9 3565.8 3567.0 587.9 663.7 690.6 699.1 700.2 732.3 750.9 764.0 779.0 823.8 9237.4 9297.4 9350.4 9511.0 9624.0 714.8 776.8 783.7 793.8 794.6 4414.4 4418.9 4496.5 4611.2 4641.4 59391.4 62087.0 62211.0 62452.4 62599.7 54733.0 54741.5 55370.7 55723.0 56801.0 48850.0 48893.3 48946.3 49989.0 50016.0 9057.8 9124.3 9156.2 9176.4 9200.9 36837.4 37673.2 38248.6 38651.8 39696.8 43833.0 43861.3 46210.5 47120.3 47562.3 10774.9 10793.6 11201.2 11230.9 11429.2 10788.9 10985.7 11095.1 11271.1 11285.7 11510.7 12450.9 12803.8 13232.6 13684.2 12547.6 12710.8 12832.1 13280.3 13456.9 11877.5 11911.9 11972.0 12170.1 12314.8 10913.2 11031.0 11036.9 11128.7 11318.0 10965.4 10989.8 11167.5 11200.8 11417.8 12:12:49 INFO - PROCESS | 10873 | -------- Summary: end -------- 12:12:49 INFO - PROCESS | 10873 | 12:12:50 INFO - TEST-INFO | 10873: exit 0 12:12:50 INFO - TEST-OK | dromaeo_css | took 1110824ms 12:12:50 INFO - TEST-START | kraken 12:12:50 INFO - operating with platform_type : linux_ 12:12:50 INFO - Initialising browser for kraken test... 12:12:50 INFO - TEST-INFO | started process 11071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIcZw2r/profile http://localhost:33235/getInfo.html) 12:12:54 INFO - PROCESS | 11071 | __metrics Screen width/height:1600/1200 12:12:54 INFO - PROCESS | 11071 | colorDepth:24 12:12:54 INFO - PROCESS | 11071 | Browser inner width/height: 1024/697 12:12:54 INFO - PROCESS | 11071 | __metrics 12:12:55 ERROR - PROCESS | 11071 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:12:56 INFO - TEST-INFO | 11071: exit 0 12:12:56 INFO - Browser initialized. 12:12:56 INFO - Running cycle 1/1 for kraken test... 12:12:56 INFO - TEST-INFO | started process 11158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIcZw2r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:13:07 INFO - PROCESS | 11158 | RSS: Main: 140578816 12:13:07 INFO - PROCESS | 11158 | 12:13:10 INFO - PROCESS | 11158 | Cycle 1(1): loaded http://localhost:33235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33235/tests/kraken/driver.html?testName=audio-beat-detection) 12:13:11 INFO - PROCESS | 11158 | RSS: Main: 197148672 12:13:11 INFO - PROCESS | 11158 | 12:13:13 INFO - PROCESS | 11158 | Cycle 1(1): loaded http://localhost:33235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33235/tests/kraken/driver.html?testName=audio-dft) 12:13:14 INFO - PROCESS | 11158 | RSS: Main: 183787520 12:13:14 INFO - PROCESS | 11158 | 12:13:17 INFO - PROCESS | 11158 | Cycle 1(1): loaded http://localhost:33235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33235/tests/kraken/driver.html?testName=audio-fft) 12:13:17 INFO - PROCESS | 11158 | RSS: Main: 272859136 12:13:17 INFO - PROCESS | 11158 | 12:13:19 INFO - PROCESS | 11158 | Cycle 1(1): loaded http://localhost:33235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33235/tests/kraken/driver.html?testName=audio-oscillator) 12:13:20 INFO - PROCESS | 11158 | RSS: Main: 180084736 12:13:20 INFO - PROCESS | 11158 | 12:13:22 INFO - PROCESS | 11158 | Cycle 1(1): loaded http://localhost:33235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:13:23 INFO - PROCESS | 11158 | RSS: Main: 178143232 12:13:23 INFO - PROCESS | 11158 | 12:13:26 INFO - PROCESS | 11158 | Cycle 1(1): loaded http://localhost:33235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33235/tests/kraken/driver.html?testName=imaging-darkroom) 12:13:26 INFO - PROCESS | 11158 | RSS: Main: 212328448 12:13:26 INFO - PROCESS | 11158 | 12:13:30 INFO - PROCESS | 11158 | Cycle 1(1): loaded http://localhost:33235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33235/tests/kraken/driver.html?testName=imaging-desaturate) 12:13:30 INFO - PROCESS | 11158 | RSS: Main: 212353024 12:13:30 INFO - PROCESS | 11158 | 12:13:33 INFO - PROCESS | 11158 | Cycle 1(1): loaded http://localhost:33235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33235/tests/kraken/driver.html?testName=json-parse-financial) 12:13:34 INFO - PROCESS | 11158 | RSS: Main: 211906560 12:13:34 INFO - PROCESS | 11158 | 12:13:35 INFO - PROCESS | 11158 | Cycle 1(1): loaded http://localhost:33235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:13:36 INFO - PROCESS | 11158 | RSS: Main: 193757184 12:13:36 INFO - PROCESS | 11158 | 12:13:37 INFO - PROCESS | 11158 | Cycle 1(1): loaded http://localhost:33235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33235/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:13:38 INFO - PROCESS | 11158 | RSS: Main: 196636672 12:13:38 INFO - PROCESS | 11158 | 12:13:40 INFO - PROCESS | 11158 | Cycle 1(1): loaded http://localhost:33235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:13:41 INFO - PROCESS | 11158 | RSS: Main: 208302080 12:13:41 INFO - PROCESS | 11158 | 12:13:43 INFO - PROCESS | 11158 | Cycle 1(1): loaded http://localhost:33235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:13:44 INFO - PROCESS | 11158 | RSS: Main: 216059904 12:13:44 INFO - PROCESS | 11158 | 12:13:46 INFO - PROCESS | 11158 | Cycle 1(1): loaded http://localhost:33235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:13:47 INFO - PROCESS | 11158 | RSS: Main: 211959808 12:13:47 INFO - PROCESS | 11158 | 12:13:49 INFO - PROCESS | 11158 | Cycle 1(1): loaded http://localhost:33235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33235/tests/kraken/driver.html?testName=ai-astar) 12:13:49 INFO - PROCESS | 11158 | RSS: Main: 273035264 12:13:49 INFO - PROCESS | 11158 | 12:13:49 INFO - PROCESS | 11158 | __start_tp_report 12:13:49 INFO - PROCESS | 11158 | _x_x_mozilla_page_load 12:13:49 INFO - PROCESS | 11158 | _x_x_mozilla_page_load_details 12:13:49 INFO - PROCESS | 11158 | |i|pagename|runs| 12:13:49 INFO - PROCESS | 11158 | |0;ai-astar;111;110;110;109;110;110;105;108;109;108 12:13:49 INFO - PROCESS | 11158 | |1;audio-beat-detection;156;130;157;179;125;152;151;132;193;131 12:13:49 INFO - PROCESS | 11158 | |2;audio-dft;162;162;161;161;160;162;160;161;162;161 12:13:49 INFO - PROCESS | 11158 | |3;audio-fft;74;74;76;169;75;74;77;74;165;76 12:13:49 INFO - PROCESS | 11158 | |4;audio-oscillator;92;93;166;91;91;93;154;92;93;145 12:13:49 INFO - PROCESS | 11158 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;117;117 12:13:49 INFO - PROCESS | 11158 | |6;imaging-darkroom;145;145;146;145;145;144;144;174;145;145 12:13:49 INFO - PROCESS | 11158 | |7;imaging-desaturate;94;95;94;94;94;95;95;95;94;94 12:13:49 INFO - PROCESS | 11158 | |8;json-parse-financial;55;56;55;57;56;54;54;73;53;52 12:13:49 INFO - PROCESS | 11158 | |9;json-stringify-tinderbox;59;59;57;57;58;58;57;57;57;57 12:13:49 INFO - PROCESS | 11158 | |10;stanford-crypto-aes;72;71;72;83;74;74;74;74;73;73 12:13:49 INFO - PROCESS | 11158 | |11;stanford-crypto-ccm;125;113;113;113;112;116;110;121;132;127 12:13:49 INFO - PROCESS | 11158 | |12;stanford-crypto-pbkdf2;160;156;157;158;158;158;162;162;156;157 12:13:49 INFO - PROCESS | 11158 | |13;stanford-crypto-sha256-iterative;66;67;65;65;66;64;65;65;64;61 12:13:49 INFO - PROCESS | 11158 | __end_tp_report 12:13:49 INFO - PROCESS | 11158 | __start_cc_report 12:13:49 INFO - PROCESS | 11158 | _x_x_mozilla_cycle_collect,1570 12:13:49 INFO - PROCESS | 11158 | __end_cc_report 12:13:49 INFO - PROCESS | 11158 | __startTimestamp1466450029322__endTimestamp 12:13:49 INFO - PROCESS | 11158 | 12:13:49 INFO - PROCESS | 11158 | ------- Summary: start ------- 12:13:49 INFO - PROCESS | 11158 | Number of tests: 14 12:13:49 INFO - PROCESS | 11158 | 12:13:49 INFO - PROCESS | 11158 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:1.70 (1.5%) stddev-sans-first:1.64 12:13:49 INFO - PROCESS | 11158 | Values: 111.0 110.0 110.0 109.0 110.0 110.0 105.0 108.0 109.0 108.0 12:13:49 INFO - PROCESS | 11158 | 12:13:49 INFO - PROCESS | 11158 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:154.00 stddev:22.33 (14.5%) stddev-sans-first:23.60 12:13:49 INFO - PROCESS | 11158 | Values: 156.0 130.0 157.0 179.0 125.0 152.0 151.0 132.0 193.0 131.0 12:13:49 INFO - PROCESS | 11158 | 12:13:49 INFO - PROCESS | 11158 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 12:13:49 INFO - PROCESS | 11158 | Values: 162.0 162.0 161.0 161.0 160.0 162.0 160.0 161.0 162.0 161.0 12:13:49 INFO - PROCESS | 11158 | 12:13:49 INFO - PROCESS | 11158 | [#3] audio-fft Cycles:10 Average:93.40 Median:74.50 stddev:38.82 (52.1%) stddev-sans-first:40.53 12:13:49 INFO - PROCESS | 11158 | Values: 74.0 74.0 76.0 169.0 75.0 74.0 77.0 74.0 165.0 76.0 12:13:49 INFO - PROCESS | 11158 | 12:13:49 INFO - PROCESS | 11158 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:92.00 stddev:30.78 (33.5%) stddev-sans-first:31.86 12:13:49 INFO - PROCESS | 11158 | Values: 92.0 93.0 166.0 91.0 91.0 93.0 154.0 92.0 93.0 145.0 12:13:49 INFO - PROCESS | 11158 | 12:13:49 INFO - PROCESS | 11158 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:13:49 INFO - PROCESS | 11158 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 12:13:49 INFO - PROCESS | 11158 | 12:13:49 INFO - PROCESS | 11158 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:145.00 stddev:9.22 (6.4%) stddev-sans-first:9.73 12:13:49 INFO - PROCESS | 11158 | Values: 145.0 145.0 146.0 145.0 145.0 144.0 144.0 174.0 145.0 145.0 12:13:49 INFO - PROCESS | 11158 | 12:13:49 INFO - PROCESS | 11158 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 12:13:49 INFO - PROCESS | 11158 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 94.0 94.0 12:13:49 INFO - PROCESS | 11158 | 12:13:49 INFO - PROCESS | 11158 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:55.50 stddev:5.99 (10.8%) stddev-sans-first:6.32 12:13:49 INFO - PROCESS | 11158 | Values: 55.0 56.0 55.0 57.0 56.0 54.0 54.0 73.0 53.0 52.0 12:13:49 INFO - PROCESS | 11158 | 12:13:49 INFO - PROCESS | 11158 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:57.50 stddev:0.84 (1.5%) stddev-sans-first:0.73 12:13:49 INFO - PROCESS | 11158 | Values: 59.0 59.0 57.0 57.0 58.0 58.0 57.0 57.0 57.0 57.0 12:13:49 INFO - PROCESS | 11158 | 12:13:49 INFO - PROCESS | 11158 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:74.00 stddev:3.33 (4.5%) stddev-sans-first:3.46 12:13:49 INFO - PROCESS | 11158 | Values: 72.0 71.0 72.0 83.0 74.0 74.0 74.0 74.0 73.0 73.0 12:13:49 INFO - PROCESS | 11158 | 12:13:49 INFO - PROCESS | 11158 | [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:118.50 stddev:7.55 (6.4%) stddev-sans-first:7.60 12:13:49 INFO - PROCESS | 11158 | Values: 125.0 113.0 113.0 113.0 112.0 116.0 110.0 121.0 132.0 127.0 12:13:49 INFO - PROCESS | 11158 | 12:13:49 INFO - PROCESS | 11158 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:158.00 stddev:2.22 (1.4%) stddev-sans-first:2.28 12:13:49 INFO - PROCESS | 11158 | Values: 160.0 156.0 157.0 158.0 158.0 158.0 162.0 162.0 156.0 157.0 12:13:49 INFO - PROCESS | 11158 | 12:13:49 INFO - PROCESS | 11158 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.62 (2.5%) stddev-sans-first:1.66 12:13:49 INFO - PROCESS | 11158 | Values: 66.0 67.0 65.0 65.0 66.0 64.0 65.0 65.0 64.0 61.0 12:13:49 INFO - PROCESS | 11158 | -------- Summary: end -------- 12:13:49 INFO - PROCESS | 11158 | 12:13:50 INFO - TEST-INFO | 11158: exit 0 12:13:50 INFO - TEST-OK | kraken | took 59723ms 12:13:50 INFO - SUITE-END | took 1170s 12:13:50 INFO - Completed test suite (00:19:30) 12:13:50 INFO - javascript benchmark 12:13:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.4752839545677, 3378.881739139129, 3391.1013581400935, 3408.6080100788417, 3432.5537680101584, 5478.808241711541, 5481.671099734014, 5483.725813709313, 5488.451154884509, 5501.284832971718, 5470.5350045246205, 5495.53287970522, 5496.5053145216925, 5506.559475241981, 5536.058869992101, 4933.580645645106, 4939.703617782944, 4951.257311403291, 5026.798928042892, 5083.18669012958, 4927.1377508935975, 4961.8511444656715, 5006.699598024112, 5026.29631851541, 5057.59539236862, 4987.875303117415, 5031.295618613397, 5042.344495215617, 5043.6721613095215, 5048.621353398491, 4935.728534930578, 4993.425756038029, 5005.174146265862, 5006.324146240266, 5014.899702005958, 4892.902141957141, 4905.975470122662, 4942.629302802268, 4947.233178857283, 4971.055499455092, 5347.6256662033675, 5348.117560602496, 5369.382521010056, 5370.758315875756, 5396.730163491809, 5799.942000579982, 5833.854153646151, 5847.06446968483, 5847.590668653153, 5847.678377689225, 5789.65262084272, 5860.3260625027815, 5909.349971503131, 5948.0, 5952.1964534787685, 5515.227868098469, 5556.388797232301, 5560.193771903051, 5565.332160140769, 5566.86082847928, 5944.554158438134, 6038.637681739022, 6049.364816694272, 6095.359987201368, 6097.664628445389, 5746.080627099644, 5817.0983497557945, 5819.53443724501, 5852.268466441695, 5853.0635098384055, 5869.442402971711, 5879.735411906475, 5887.528997680175, 5892.204552385373, 5893.233879595625, 5779.653220806681, 5833.591648584643, 5851.970740146272, 5863.472287494061, 5864.970675146597, 5806.187133801272, 5855.063189889597, 5869.383714709894, 5886.440788125121, 5896.469317761422, 4477.977610111929, 4504.6396288296855, 4508.81964721414, 4511.413516242867, 4535.455745310518, 3949.743266687656, 4008.0581063450068, 4051.2707712611423, 4057.046594050396, 4087.5912408758886, 5617.943820561742, 5631.605787594829, 5644.520215781622, 5662.716864156776, 5666.065099258659, 5865.912011319833, 5867.325257595431, 5869.735861886225, 5885.293764748258, 5890.852728681732, 5482.972585137129, 5620.578456615688, 5637.746301416446, 5647.519960803295, 5677.37548869624, 5092.745362731848, 5095.668781529189, 5096.923546146811, 5102.030614183293, 5123.180291153398, 6103.42017508336, 6112.969435152796, 6115.0215965446205, 6120.60216085953, 6121.540884433685, 5759.856003599776, 5862.648241105548, 5885.17607534954, 5894.587378883437, 5921.171036055042, 6074.51403887679, 6077.088436734349, 6079.483243924316, 6111.358307377662, 6116.204893363834, 5744.684042377709, 5773.364929857628, 5785.768569257182, 5789.739461724148, 5793.507551858139, 5761.884762304814, 5805.274340707411, 5867.882642347044, 5870.559708022, 5915.497182739516, 5762.164486149569, 5767.509761670305, 5769.798057067983, 5775.8556036099435, 5784.566157538117, 5700.429957004267, 5749.166370876116, 5756.222909907109, 5760.769569217352, 5768.913466298093, 5539.529140022982, 5592.189132575835, 5641.069223578063, 5658.236138121301, 5682.516986056232, 5751.252337196138, 5769.769209231584, 5784.016717158009, 5787.0, 5794.3626201117, 5655.4910058094965, 5666.15007748841, 5667.376588575171, 5668.206451096932, 5697.686627235542], "value": 5430.406558871772, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.5871786544085, 661.5468404143162, 674.4469534981317, 675.932406759324, 676.8883134282846, 36456.088597785034, 37231.255374892484, 39745.20509589806, 40851.795741021255, 40933.18133637326, 45830.31254531185, 46506.53493465064, 46602.30096548554, 46649.30026049612, 46677.0, 8170.836583268331, 9029.683961061348, 9270.582823772946, 9275.536223188847, 10349.430781307025, 10815.0, 10990.17573681973, 10998.395088270141, 11002.174836887265, 11012.669619911416, 10989.395583242958, 11082.833757493603, 11083.778324433506, 11086.889131108706, 11097.278676885977, 10891.945540272287, 10939.234253602252, 10941.452927353681, 10989.175811814066, 10991.450427478594, 10969.670909872717, 11059.944700276446, 11071.833922491169, 11090.445477726082, 11107.888921110767, 43782.12435751267, 43983.56016439859, 44366.0, 44371.77814110909, 44441.111177776584, 3775.339315619756, 3793.2982398256136, 3877.3214687429586, 4169.312063509517, 4493.887652808673, 33058.3388332232, 33092.83453582741, 33128.3374332512, 33198.0, 33446.0, 4532.750698711569, 4583.312503124558, 4613.308003799423, 4662.207424737802, 4669.7665116744365, 311255.0, 311867.0, 312345.0, 312593.0, 313527.0, 60187.69906150441, 60911.0, 60915.39084609186, 60915.39084609186, 60932.0, 65245.347546523924, 71986.0, 73715.0, 73717.0, 73753.26246737571, 18537.81462185388, 18831.62336753257, 18831.90584047071, 18879.0, 18885.716714249298, 13938.93030534841, 14983.400663973536, 15169.165695886612, 15468.92265538665, 15525.922370388076, 19535.70126685945, 20357.796422035888, 20358.796412035987, 20397.49006274855, 20533.178672853217, 7197.568145911262, 7397.630118494054, 7403.14863790671, 7434.888476672854, 7503.124218945263, 1052.1004541117388, 1070.4380200394855, 1121.484117306032, 1141.6974501756874, 1154.6132045764764, 32740.0, 33879.66120338815, 34185.31629367399, 34285.0, 34381.14047148841, 1195.4261954262004, 1196.7486827766093, 1244.993775031119, 1273.9490420383265, 1279.9424025918856, 17198.928814101124, 17599.296028158988, 17632.647347052985, 17785.911070444825, 17852.91073544624, 488482.0, 488581.0, 491802.0, 493909.0, 494146.0, 62529.374706253264, 63222.051669224995, 63238.36761632417, 63290.0, 63304.366956329846, 1387.070662656023, 1480.3930388540646, 1482.740520408924, 1482.8813694904381, 1587.428525730736, 30491.847540763043, 31184.844075779474, 32250.516242256854, 32266.19334516562, 32888.50667239945, 45492.0, 45618.771906141585, 45978.54021459876, 45997.0, 46017.0, 309100.0, 311397.0, 312011.0, 312276.0, 312898.0, 27282.0, 31085.378292433572, 31719.841400792848, 31738.523922140725, 31760.68239317577, 46008.0, 48749.0, 49073.0, 49758.50241497539, 50123.0, 39683.60316396799, 40456.0, 40628.59371406248, 40801.38797918093, 41356.58643413527, 39809.80095099506, 40026.79986600048, 40218.0, 40332.0, 41247.58752412438, 41514.1697166049, 41932.0, 42443.0, 42820.78589607032, 42871.7856410716, 34871.8615324622, 36709.0, 37482.62517374791, 37819.243615126994, 38404.0, 28745.281367965967, 28773.56839647449, 29078.41843163167, 29086.85456572788, 29112.27219319534], "value": 21115.0466334783, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.96353809926154, 431.88770919560903, 434.0358940794945, 437.2108344438289, 439.61533658049206, 18468.0, 18897.90551047246, 19082.61834763304, 19167.520811979706, 19840.702389464168, 18594.721079183822, 18911.148998295077, 19983.500412489695, 19996.0, 20023.299184528507, 5696.316442026942, 5705.77176912923, 5914.704264786765, 5918.556108291874, 5918.704064796743, 4369.431973843396, 5817.738201780909, 5870.559708021894, 6147.784827531037, 6464.095026696266, 6420.7752728654505, 6468.126802881621, 6472.352764723537, 6476.838079048014, 6482.254540727806, 5996.340402555716, 6302.779402720928, 6312.873742525147, 6313.463355614732, 6444.677766111676, 3862.4206369044587, 4426.690131690783, 5661.46216109469, 5682.829515114553, 5695.231143795576, 13994.090384125, 14147.221902795445, 14178.078424902451, 14230.146191228456, 20339.694904576445, 2488.925332240036, 2573.2630474429684, 2653.4162484253434, 2689.542777727791, 3099.7985130966417, 9744.366616169926, 10141.0, 10254.589816407335, 10275.588976440933, 10453.0, 1969.241841890868, 2010.6380851446734, 2043.2914260616933, 2148.409187473457, 2166.9783302166934, 75689.24310756876, 76590.61704691441, 77016.0, 77035.22964770392, 81982.6609502036, 11259.268147570545, 11420.600278990361, 11468.0, 11651.485306910217, 11884.88115118855, 16282.837171628133, 16490.0, 16500.75248871268, 16528.586785330222, 16538.338466461446, 8943.3739638226, 9011.774705632411, 9095.363324567217, 9136.0, 9193.080691930754, 8870.334724895529, 8884.8667269991, 8894.42186257891, 9017.143371379709, 9034.0, 5017.949820501822, 5053.898922021539, 5087.720175390315, 5091.770870310771, 5152.639315247971, 1825.361123606727, 1973.289615738333, 2013.3758534854242, 2088.1229883448987, 2121.9257325993517, 1012.7721262715977, 1031.8039572481205, 1053.2364036073939, 1079.2893264176212, 1080.1197024425069, 17811.554711132325, 18034.188461519, 18195.27218911255, 18470.445886623424, 18914.0, 1010.7372083258406, 1048.4810019040624, 1056.4823236614156, 1097.6103483263487, 1147.8966892979504, 10283.691489255334, 10652.414117223627, 11170.218084734153, 11183.944080279547, 11271.0, 443170.0, 465110.0, 468562.0, 470738.0, 470922.0, 96679.0, 99645.0, 99770.0, 100427.49786251022, 101649.49175254225, 1119.2109562758399, 1138.4706111658118, 1172.5778719660916, 1178.3224645828682, 1195.7010747313172, 17216.827831721523, 17246.741298880275, 17657.735133972743, 17881.46355609334, 18057.909710451364, 38321.0, 38731.6126838728, 38916.41625375678, 41049.589504105774, 41184.1763164741, 51229.23156152586, 54341.0, 57299.0, 57740.422595775184, 57975.13037304528, 9163.633454661738, 9280.535973201448, 9332.440053596534, 9449.29130315243, 9599.376040557341, 11983.34091624969, 13276.867231327564, 13304.334783260605, 13474.730505390033, 13844.30778461093, 11612.0, 11831.230969986924, 11975.28148311104, 12126.393680316125, 12321.93839030799, 11484.425778711198, 11622.244554104294, 11749.588764393206, 12021.639350819489, 12076.335801531, 12150.878491214975, 12407.25556466615, 12419.254844709347, 12739.936300318439, 12784.296863672587, 8957.820843582962, 9089.227415669742, 9224.538773061186, 9279.443233406017, 9565.963732172786, 11958.940205299266, 12031.578894738643, 12172.0, 12399.814002790146, 12570.685732856751], "value": 9462.978013016529, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.2315080404173, 1494.4545240987043, 1515.272669118823, 1686.2327640923381, 1852.3053854804448, 8197.75406737798, 8392.916070839297, 8401.621927013291, 8416.91583084169, 8421.831563368729, 8178.100408955011, 8333.416660833744, 8339.082700902896, 8343.08226095129, 8350.95824520878, 2330.813534917211, 2345.566070277004, 2346.1671106757112, 2352.541254455382, 2352.9529409411803, 2380.143148466551, 2391.689080419543, 2438.7073551173885, 2460.507898420314, 2467.148833652387, 2331.5453486570127, 2340.262817212581, 2348.8825558722083, 2379.8572085674914, 2400.543896659629, 2314.409825494505, 2319.2926157521947, 2386.3795413192606, 2401.747816479262, 2402.4354276744953, 2388.8088952883727, 2451.644511545816, 2462.495188486356, 2469.1975108089764, 2469.790067844235, 7122.821929451753, 8095.028596568391, 8576.571171441403, 8629.741107766777, 8637.0, 5203.895922081537, 5277.313949186581, 5278.841634750964, 5317.813876514303, 5330.440303768088, 3500.3699334119847, 3515.859365625372, 3592.0121966459174, 3664.8167591620577, 3694.131879008431, 1235.2773627427966, 1241.944112514939, 1252.8621851596408, 1263.3367482071894, 1287.671643730852, 11313.943430282878, 11661.24201926872, 11680.707982300426, 11693.941530292293, 11739.354335511543, 4540.841070562515, 4627.745473998963, 4673.836415725434, 4715.504871988392, 4719.646026548023, 10091.545880435398, 10097.899021009844, 10098.242631802645, 10104.797904041878, 10119.595216191417, 5320.813771517978, 5345.438728933484, 5349.919751203735, 5352.170413585901, 5356.276902618097, 4901.803927842846, 4902.1911384621135, 4905.533974272438, 4910.680805747615, 4918.680285781485, 3812.3709587917683, 3886.8833934981994, 3901.941470877939, 3904.7657140571655, 3923.4507168996365, 1173.9354335511457, 1173.9647810565696, 1177.087756988341, 1191.7020744813797, 1205.7769312677183, 970.3304719743495, 984.3945973226414, 1005.1506477026901, 1012.1618662791867, 1017.6692574913183, 5865.826834633005, 5896.321922978912, 5950.464458198783, 6035.39646035393, 6056.788012419544, 930.7254359963827, 1009.5255230041869, 1019.8062368150028, 1031.4584842957358, 1042.921780866438, 3849.1339448624394, 3978.5822488638855, 3986.647972497613, 4016.59834016596, 4027.8791636250958, 10492.842607360895, 10707.73230669224, 10821.621243256448, 10830.133589312836, 10841.024307812335, 10605.681829545127, 10666.573337066586, 10676.62631807883, 10677.626283080055, 10684.57261709523, 8075.596220188967, 8131.18688131194, 8214.219649133442, 8225.136360682161, 8227.053888802864, 5658.85852853682, 5660.575456840671, 5677.347105082803, 5690.77236910519, 5793.131030345482, 9299.67451139207, 9335.533223338942, 9461.716148515556, 9481.57332920034, 9482.57328420209, 9372.718818435458, 9459.479728614991, 9614.615415383307, 9649.372790768577, 9708.951455242679, 7837.6081195941115, 7872.881906771518, 7960.084590272193, 7999.160088190889, 8005.3995950305125, 8056.033276006917, 8070.596470176585, 8131.0, 8215.383846211678, 8227.177282271725, 7138.571685698875, 7331.560106393634, 7404.851902962018, 7421.443391745533, 7437.553746775211, 7567.129780075362, 7604.467687261838, 7678.500897441649, 7736.226377362219, 7790.88313675284, 6848.075509806113, 6976.651167441709, 6992.755253566101, 7156.785296441115, 7187.604681742345, 4599.724016559017, 4670.0, 4804.42346918372, 4812.085703716282, 4928.310036594808, 4720.716756994591, 4720.976395118139, 4721.315409265569, 4787.234042553175, 4831.4202295724735], "value": 4601.674599504551, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.8679182098533, 364.2787281183259, 366.06105339803395, 367.25447341895955, 367.968722658574, 6077.848053798657, 6086.634801911889, 6086.8478288042825, 6128.3258841527395, 6136.079588061793, 5922.763089476416, 6009.4591486766185, 6077.939220607793, 6085.178500902377, 6110.908336374947, 4689.226277664181, 4729.976350118244, 4734.763261836912, 4753.786079626408, 4764.190087685102, 4745.525447455261, 4753.239481682931, 4760.214564596838, 4832.323474713543, 4837.6129909607325, 4549.522300158485, 4786.688865223767, 4788.0663270662235, 4794.256890182028, 4795.352627395292, 4637.142128706183, 4760.190767569521, 4795.904081918342, 4797.472278049412, 4815.975920120412, 4239.936400953989, 4241.809118589671, 4244.469441319835, 4245.745255284662, 4247.5752424757275, 6054.69726513677, 6057.818265452043, 6068.757249710006, 6078.057901025348, 6078.422549857756, 5648.576356773217, 5653.095504719226, 5653.745581448845, 5656.519195868356, 5669.9433005669825, 6323.462505687022, 6648.235452922928, 6651.23510796255, 6651.80044598658, 6653.667316634197, 4513.097380523908, 4544.068465964469, 4545.318202269653, 4545.840895568639, 4550.7497087660495, 6875.312468753134, 6952.331440454254, 6959.4432445404755, 6962.582245065312, 6967.8606427871155, 4725.5983241424865, 4746.833860814855, 4748.19280722278, 4751.572358487752, 4753.548412900769, 4793.065352256276, 4815.566599006036, 4817.494163112893, 4817.542333478314, 4818.036392721469, 5529.0, 5555.916661250085, 5556.277683901148, 5558.249636299129, 5558.416366281483, 6465.612063276219, 6699.43054840344, 6702.932970670328, 6707.0610114584, 6710.597364158166, 1657.2376706714806, 1688.1643586424552, 1692.3061544766833, 1694.3900195929455, 1697.4313604942236, 1045.268312181476, 1078.2398409121706, 1094.2996482251365, 1123.0678536814423, 1127.8702949160788, 6348.873022539616, 6452.193475815523, 6479.5788273762055, 6486.4486518646445, 6491.221053473613, 6807.0, 6820.931790682129, 6831.385175334244, 6838.658067096725, 6840.48696347766, 6446.967765161145, 6462.935370646233, 6464.256610489854, 6468.773592924225, 6470.38531339522, 3643.890683279506, 3675.9264814703556, 3686.7419280650097, 3686.9262614747554, 3688.5389326334207, 7001.299870012958, 7290.125184977731, 7290.8177295566975, 7312.96343518279, 7327.303906128909, 7058.505904586629, 7104.7158113675905, 7105.32499412555, 7106.502544821917, 7111.324424179695, 7276.054112965387, 7285.672144753499, 7287.781366559012, 7290.890636640454, 7304.160021597372, 6799.93200067993, 6926.134233220848, 6930.826729331807, 6936.0, 6943.618101004493, 6794.694238759366, 6795.116634837439, 6804.21751498584, 6805.557638753465, 6828.795136145924, 7228.855422891618, 7269.636518173965, 7277.745278915212, 7278.599677017814, 7286.234945330876, 4721.787519561559, 4754.334393185026, 4755.548222918817, 4755.667103302736, 4760.761961901821, 6889.862202756017, 6891.207511136284, 6900.275471075464, 6900.551464154814, 6953.75661851853, 6555.4427873631275, 6691.76578819739, 6697.2633010367845, 6706.8993965089585, 6708.731650733916, 6649.833754155991, 6664.366885145903, 6673.499487538551, 6682.599044057372, 6697.0958920547055, 6559.245686745894, 6570.178727659043, 6576.671166441563, 6576.8355791103695, 6581.407673309425, 6752.898706519308, 6753.358430949052, 6756.391924726799, 6816.522843400914, 6840.623765692736, 6322.905156422566, 6409.615423074631, 6416.454601358937, 6557.442617377576, 6594.604323740591], "value": 5032.280654823424, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.6925229908039, 772.2354868680005, 839.3998291221775, 880.4145243413129, 898.8471959766841, 14013.439462421504, 14340.498082567112, 14346.139231646108, 14390.496332628372, 14391.42434302628, 14217.928910355433, 14326.283685815693, 14338.13971161731, 14506.347214375352, 14507.27463626817, 724.3915111306502, 880.4013270975734, 883.147762409275, 890.2521881619471, 905.5743800413795, 892.0722448653393, 896.3814967672286, 904.398574947659, 904.900460949295, 905.4386280506095, 936.7330310861406, 947.3415975896754, 949.2500924269818, 949.952502374882, 950.9286803489731, 767.0, 909.4634165842152, 925.5048549026305, 925.6297481007583, 928.3687092776909, 687.3298533929429, 689.0422312984905, 689.6172624193571, 690.4786885901162, 691.0360047733434, 14099.577012689635, 14150.929245353811, 14207.78688319676, 14235.145891246455, 14284.0, 13092.607221783363, 13230.404631791593, 13530.25583592902, 13717.519886804013, 14702.411903523845, 10804.243702940797, 10964.451777411097, 11131.777364452746, 11352.602658906899, 11596.76806463866, 3955.7230993830444, 3957.0700885291935, 4004.2191772604356, 4006.419069234945, 4043.636072753437, 52738.0, 53275.93448131054, 53315.334233288566, 53975.73012134954, 54007.45992540103, 10457.477126143662, 10814.945925270324, 11737.941310293394, 11864.288212661666, 11994.220375675553, 20082.39752807418, 20245.392638220583, 20250.088746006466, 20554.38336849897, 20567.07448164836, 8594.5702714864, 8848.690295839615, 8878.245349145265, 8890.644374225089, 8980.652902064612, 4783.856484305476, 4821.156297647897, 4821.5178482152205, 4854.902901941941, 4871.074495845778, 3478.913027174341, 3502.1069627245397, 3558.893233203008, 3565.750397472204, 3566.964330356715, 587.9470847623735, 663.7146027208347, 690.6167077272062, 699.0841996983967, 700.1982729774481, 732.3372348025046, 750.8911207874828, 763.9618019099023, 778.9561986937531, 823.8228780812034, 9237.399569027992, 9297.426810093068, 9350.438973661467, 9510.952445237868, 9624.0, 714.7819914925998, 776.8096816280048, 783.7100272899064, 793.8234014789057, 794.5550491724653, 4414.404055452537, 4418.911621767546, 4496.482904465963, 4611.193041217841, 4641.419822522184, 59391.40608593945, 62087.0, 62211.0, 62452.375476245565, 62599.68700156561, 54733.0, 54741.452585473635, 55370.72314638401, 55723.0, 56801.0, 48850.0, 48893.266601001014, 48946.26580601294, 49989.0, 50016.0, 9057.81884362296, 9124.31567632417, 9156.175944165057, 9176.44941303524, 9200.907990920005, 36837.44743828898, 37673.246535068596, 38248.61751382562, 38651.806740966116, 39696.801515992236, 43833.0, 43861.34207986819, 46210.537894620626, 47120.29319560278, 47562.28656570085, 10774.934819030068, 10793.56825726962, 11201.159913006393, 11230.94384528072, 11429.199956003, 10788.892111078789, 10985.725356866142, 11095.056920161876, 11271.098312134845, 11285.661430157108, 11510.712232194262, 12450.937745311216, 12803.80794288105, 13232.603021909357, 13684.247366394944, 12547.623571292876, 12710.809337859755, 12832.101752877208, 13280.335983200994, 13456.932715336361, 11877.524899003944, 11911.940440297743, 11972.0, 12170.14808963364, 12314.81527777102, 10913.23607347478, 11031.0, 11036.889631103586, 11128.721781955192, 11318.0, 10965.396903170084, 10989.835152472559, 11167.497462614365, 11200.775984480428, 11417.828732568853], "value": 6916.561268078213, "unit": "score"}], "name": "dromaeo_css", "value": 7470.4033054944275, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 110.0, 109.0, 110.0, 110.0, 105.0, 108.0, 109.0, 108.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 157.0, 179.0, 125.0, 152.0, 151.0, 132.0, 193.0, 131.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 160.0, 162.0, 160.0, 161.0, 162.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 169.0, 75.0, 74.0, 77.0, 74.0, 165.0, 76.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 166.0, 91.0, 91.0, 93.0, 154.0, 92.0, 93.0, 145.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 144.0, 144.0, 174.0, 145.0, 145.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 57.0, 56.0, 54.0, 54.0, 73.0, 53.0, 52.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 57.0, 57.0, 58.0, 58.0, 57.0, 57.0, 57.0, 57.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 83.0, 74.0, 74.0, 74.0, 74.0, 73.0, 73.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 113.0, 113.0, 113.0, 112.0, 116.0, 110.0, 121.0, 132.0, 127.0], "value": 118.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 156.0, 157.0, 158.0, 158.0, 158.0, 162.0, 162.0, 156.0, 157.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 65.0, 66.0, 64.0, 65.0, 65.0, 64.0, 61.0], "value": 64.8, "unit": "score"}], "name": "kraken", "value": 1513.6999999999998, "alertThreshold": 2.0}]} 12:13:50 INFO - Return code: 0 12:13:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:13:50 ERROR - # TBPL SUCCESS # 12:13:50 INFO - Running post-action listener: _resource_record_post_action 12:13:50 INFO - Running post-run listener: _resource_record_post_run 12:13:51 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 476172288; Read time: 20; Write time: 429500 12:13:51 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 218345472; Read time: 0; Write time: 305260 12:13:51 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221356032; Read time: 20; Write time: 110216 12:13:51 INFO - Running post-run listener: _upload_blobber_files 12:13:51 INFO - Blob upload gear active. 12:13:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:13:51 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 12:13:51 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'] 12:13:51 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 12:13:52 INFO - (blobuploader) - INFO - Open directory for files ... 12:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:13:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:13:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:13:52 INFO - (blobuploader) - INFO - Done attempting. 12:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:13:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:13:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:13:53 INFO - (blobuploader) - INFO - Done attempting. 12:13:53 INFO - (blobuploader) - INFO - Iteration through files over. 12:13:53 INFO - Return code: 0 12:13:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:13:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:13:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a49d6262057cb1f6fe0735ae36cb5b21db9616786a0107bb42fc77f6b60816ea9998da1c5cd486fa1ca49b156e8b0dc2a4236693cabbe4bc9fc8c13fe0961510", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7b0e8d3f27168824dc3393e60b4517996d9cf6f448ea6c32fb571d40331ac1d4fa192e9c5f166ff8ba32cc5681af49be04c6d8f46f7da6c1a329111ea78fe90e"} 12:13:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:13:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:13:53 INFO - Contents: 12:13:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a49d6262057cb1f6fe0735ae36cb5b21db9616786a0107bb42fc77f6b60816ea9998da1c5cd486fa1ca49b156e8b0dc2a4236693cabbe4bc9fc8c13fe0961510", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7b0e8d3f27168824dc3393e60b4517996d9cf6f448ea6c32fb571d40331ac1d4fa192e9c5f166ff8ba32cc5681af49be04c6d8f46f7da6c1a329111ea78fe90e"} 12:13:53 INFO - Running post-run listener: copy_logs_to_upload_dir 12:13:53 INFO - Copying logs to upload dir... 12:13:53 INFO - mkdir: /builds/slave/test/build/upload/logs 12:13:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.467324 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-06-20 12:13:53.424850) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 12:13:53.428091) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a49d6262057cb1f6fe0735ae36cb5b21db9616786a0107bb42fc77f6b60816ea9998da1c5cd486fa1ca49b156e8b0dc2a4236693cabbe4bc9fc8c13fe0961510", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7b0e8d3f27168824dc3393e60b4517996d9cf6f448ea6c32fb571d40331ac1d4fa192e9c5f166ff8ba32cc5681af49be04c6d8f46f7da6c1a329111ea78fe90e"} build_url:https://queue.taskcluster.net/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/CvEkmftERfy8uT35PN-qSg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a49d6262057cb1f6fe0735ae36cb5b21db9616786a0107bb42fc77f6b60816ea9998da1c5cd486fa1ca49b156e8b0dc2a4236693cabbe4bc9fc8c13fe0961510", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7b0e8d3f27168824dc3393e60b4517996d9cf6f448ea6c32fb571d40331ac1d4fa192e9c5f166ff8ba32cc5681af49be04c6d8f46f7da6c1a329111ea78fe90e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 12:13:53.459046) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 12:13:53.459398) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466448622.891723-204062040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 12:13:53.543052) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 12:13:53.543995) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 12:13:53.544801) ========= ========= Total master_lag: 0.18 =========