builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1462529727.15 results: success (0) buildid: 20160505123841 builduid: 1457772db7ef4c1982b4796b67a4914d revision: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.149608) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.150011) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.150543) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.202968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.203440) ========= 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=aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 03:15:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.4M=0s 2016-05-06 03:15:27 (25.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090588 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.317635) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.318035) ========= 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=aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017774 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.368999) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.369294) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b --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-aurora --rev 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b --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=aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 03:15:28,117 truncating revision to first 12 chars 2016-05-06 03:15:28,117 Setting DEBUG logging. 2016-05-06 03:15:28,117 attempt 1/10 2016-05-06 03:15:28,117 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0123e9f41ced?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 03:15:28,415 unpacking tar archive at: mozilla-aurora-0123e9f41ced/testing/mozharness/ program finished with exit code 0 elapsedTime=0.587923 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.970756) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.971120) ========= script_repo_revision: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.971525) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.971822) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.982343) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-06 03:15:27.982778) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:15:28 INFO - MultiFileLogger online at 20160506 03:15:28 in /builds/slave/test 03:15:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:15:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:15:28 INFO - {'append_to_log': False, 03:15:28 INFO - 'base_work_dir': '/builds/slave/test', 03:15:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:15:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:15:28 INFO - 'branch': 'Mozilla-Aurora', 03:15:28 INFO - 'buildbot_json_path': 'buildprops.json', 03:15:28 INFO - 'config_files': ('talos/linux_config.py',), 03:15:28 INFO - 'default_actions': ('clobber', 03:15:28 INFO - 'read-buildbot-config', 03:15:28 INFO - 'download-and-extract', 03:15:28 INFO - 'populate-webroot', 03:15:28 INFO - 'create-virtualenv', 03:15:28 INFO - 'install', 03:15:28 INFO - 'run-tests'), 03:15:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:15:28 INFO - 'download_minidump_stackwalk': True, 03:15:28 INFO - 'download_symbols': 'ondemand', 03:15:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:15:28 INFO - 'tooltool.py': '/tools/tooltool.py', 03:15:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:15:28 INFO - '/tools/misc-python/virtualenv.py')}, 03:15:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:15:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:15:28 INFO - 'installer_path': 'installer.exe', 03:15:28 INFO - 'log_level': 'info', 03:15:28 INFO - 'log_name': 'talos', 03:15:28 INFO - 'log_to_console': True, 03:15:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:15:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:15:28 INFO - 'opt_config_files': (), 03:15:28 INFO - 'pip_index': False, 03:15:28 INFO - 'sps_profile': False, 03:15:28 INFO - 'sps_profile_interval': 0, 03:15:28 INFO - 'suite': 'dromaeojs', 03:15:28 INFO - 'system_bits': '32', 03:15:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:15:28 INFO - 'title': 'talos-linux64-ix-009', 03:15:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:15:28 INFO - 'use_talos_json': True, 03:15:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:15:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:15:28 INFO - 'work_dir': 'build'} 03:15:28 INFO - ##### 03:15:28 INFO - ##### Running clobber step. 03:15:28 INFO - ##### 03:15:28 INFO - Running pre-action listener: _resource_record_pre_action 03:15:28 INFO - Running main action method: clobber 03:15:28 INFO - rmtree: /builds/slave/test/build 03:15:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:15:29 INFO - Running post-action listener: _resource_record_post_action 03:15:29 INFO - ##### 03:15:29 INFO - ##### Running read-buildbot-config step. 03:15:29 INFO - ##### 03:15:29 INFO - Running pre-action listener: _resource_record_pre_action 03:15:29 INFO - Running main action method: read_buildbot_config 03:15:29 INFO - Using buildbot properties: 03:15:29 INFO - { 03:15:29 INFO - "project": "", 03:15:29 INFO - "product": "firefox", 03:15:29 INFO - "script_repo_revision": "production", 03:15:29 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:15:29 INFO - "repository": "", 03:15:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:15:29 INFO - "buildid": "20160505123841", 03:15:29 INFO - "pgo_build": "True", 03:15:29 INFO - "basedir": "/builds/slave/test", 03:15:29 INFO - "buildnumber": 487, 03:15:29 INFO - "slavename": "talos-linux64-ix-009", 03:15:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:15:29 INFO - "platform": "ubuntu64_hw", 03:15:29 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:15:29 INFO - "branch": "mozilla-aurora", 03:15:29 INFO - "repo_path": "releases/mozilla-aurora", 03:15:29 INFO - "revision": "0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b", 03:15:29 INFO - "stage_platform": "linux64-pgo", 03:15:29 INFO - "builduid": "1457772db7ef4c1982b4796b67a4914d", 03:15:29 INFO - "slavebuilddir": "test" 03:15:29 INFO - } 03:15:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:15:29 INFO - Running post-action listener: _resource_record_post_action 03:15:29 INFO - ##### 03:15:29 INFO - ##### Running download-and-extract step. 03:15:29 INFO - ##### 03:15:29 INFO - Running pre-action listener: _resource_record_pre_action 03:15:29 INFO - Running main action method: download_and_extract 03:15:29 INFO - mkdir: /builds/slave/test/build/tests 03:15: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')]} 03:15:29 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:15:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:15:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:15:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:15:33 INFO - Downloaded 1361 bytes. 03:15:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:15:33 INFO - Using the following test package requirements: 03:15:33 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:15:33 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:33 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:15:33 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:33 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:15:33 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:33 INFO - u'jsshell-linux-x86_64.zip'], 03:15:33 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:33 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:15:33 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:15:33 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:33 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:15:33 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:33 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:15:33 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:33 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:15:33 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:33 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:15:33 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:33 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:15:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:15:36 INFO - Downloaded 23824026 bytes. 03:15:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:15:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:15:37 INFO - Return code: 0 03:15:37 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:37 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:15:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:15:48 INFO - Downloaded 23824026 bytes. 03:15:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:15:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:15:49 INFO - Return code: 0 03:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:49 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:15:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:15:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:15:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:15:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:15:50 INFO - Downloaded 10840145 bytes. 03:15:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:15:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:15:51 INFO - Return code: 0 03:15: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')]} 03:15:51 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:15:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:15:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:15:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:15:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:15:52 INFO - Downloaded 62687148 bytes. 03:15:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:15:52 INFO - mkdir: /builds/slave/test/properties 03:15:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:15:52 INFO - Writing to file /builds/slave/test/properties/build_url 03:15:52 INFO - Contents: 03:15:52 INFO - build_url:https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:15:53 INFO - Running post-action listener: _resource_record_post_action 03:15:53 INFO - Running post-action listener: set_extra_try_arguments 03:15:53 INFO - ##### 03:15:53 INFO - ##### Running populate-webroot step. 03:15:53 INFO - ##### 03:15:53 INFO - Running pre-action listener: _resource_record_pre_action 03:15:53 INFO - Running main action method: populate_webroot 03:15:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:15:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:15:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:15:53 INFO - '--tppagecycles', 03:15:53 INFO - '7'], 03:15:53 INFO - 'tests': ['tsvgm']}}, 03:15:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:15:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:15:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:15:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:15:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:15:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:15:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:53 INFO - 'talos_options': ['--disable-e10s'], 03:15:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:53 INFO - 'talos_options': ['--disable-e10s'], 03:15:53 INFO - 'tests': ['damp', 'tps']}, 03:15:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:53 INFO - 'tests': ['damp', 'tps']}, 03:15:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:15:53 INFO - 'tests': ['dromaeo_dom']}, 03:15:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:15:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:15:53 INFO - 'tests': ['a11yr', 03:15:53 INFO - 'ts_paint', 03:15:53 INFO - 'tpaint', 03:15:53 INFO - 'sessionrestore', 03:15:53 INFO - 'sessionrestore_no_auto_restore', 03:15:53 INFO - 'tabpaint']}, 03:15:53 INFO - 'other-e10s': {'tests': ['a11yr', 03:15:53 INFO - 'ts_paint', 03:15:53 INFO - 'tpaint', 03:15:53 INFO - 'sessionrestore', 03:15:53 INFO - 'sessionrestore_no_auto_restore', 03:15:53 INFO - 'tabpaint']}, 03:15:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:15:53 INFO - 'ts_paint', 03:15:53 INFO - 'tpaint', 03:15:53 INFO - 'sessionrestore', 03:15:53 INFO - 'sessionrestore_no_auto_restore', 03:15:53 INFO - 'tabpaint']}, 03:15:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:15:53 INFO - 'ts_paint', 03:15:53 INFO - 'tpaint', 03:15:53 INFO - 'sessionrestore', 03:15:53 INFO - 'sessionrestore_no_auto_restore', 03:15:53 INFO - 'tabpaint']}, 03:15:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:15:53 INFO - 'tests': ['a11yr', 03:15:53 INFO - 'ts_paint', 03:15:53 INFO - 'tpaint', 03:15:53 INFO - 'sessionrestore', 03:15:53 INFO - 'sessionrestore_no_auto_restore', 03:15:53 INFO - 'tabpaint']}, 03:15:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:15:53 INFO - 'tests': ['a11yr', 03:15:53 INFO - 'ts_paint', 03:15:53 INFO - 'tpaint', 03:15:53 INFO - 'sessionrestore', 03:15:53 INFO - 'sessionrestore_no_auto_restore', 03:15:53 INFO - 'tabpaint']}, 03:15:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:15:53 INFO - 'tests': ['tsvgx', 03:15:53 INFO - 'tsvgr_opacity', 03:15:53 INFO - 'tart', 03:15:53 INFO - 'tscrollx', 03:15:53 INFO - 'cart']}, 03:15:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:15:53 INFO - 'tsvgr_opacity', 03:15:53 INFO - 'tart', 03:15:53 INFO - 'tscrollx', 03:15:53 INFO - 'cart']}, 03:15:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:53 INFO - 'talos_options': ['--disable-e10s'], 03:15:53 INFO - 'tests': ['tp5o']}, 03:15:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:53 INFO - 'tests': ['tp5o']}, 03:15:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:53 INFO - 'talos_options': ['--disable-e10s', 03:15:53 INFO - '--xperf_path', 03:15:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:53 INFO - 'tests': ['tp5n']}, 03:15:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:53 INFO - 'talos_options': ['--xperf_path', 03:15:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:53 INFO - 'tests': ['tp5n']}}, 03:15:53 INFO - 'talos.zip': {'path': '', 03:15:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:15:53 INFO - Running post-action listener: _resource_record_post_action 03:15:53 INFO - ##### 03:15:53 INFO - ##### Running create-virtualenv step. 03:15:53 INFO - ##### 03:15:53 INFO - Running pre-action listener: _resource_record_pre_action 03:15:53 INFO - Running main action method: create_virtualenv 03:15:53 INFO - Creating virtualenv /builds/slave/test/build/venv 03:15:53 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 03:15:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:15:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:15:53 INFO - Using real prefix '/usr' 03:15:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:15:53 INFO - Installing distribute.............................................................................................................................................................................................done. 03:15:55 INFO - Installing pip.................done. 03:15:55 INFO - Return code: 0 03:15:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:15: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')]} 03:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15: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')]} 03:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:55 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 0x7faa5ba68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', '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 03:15:55 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 03:15:55 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 03:15:55 INFO - Using env: {'DISPLAY': ':0', 03:15:55 INFO - 'HOME': '/home/cltbld', 03:15:55 INFO - 'LANG': 'en_US.UTF-8', 03:15:55 INFO - 'LANGUAGE': 'en_US:en', 03:15:55 INFO - 'LOGNAME': 'cltbld', 03:15:55 INFO - 'MAIL': '/var/mail/cltbld', 03:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:55 INFO - 'MOZ_NO_REMOTE': '1', 03:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:55 INFO - 'NO_EM_RESTART': '1', 03:15:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:55 INFO - 'PWD': '/builds/slave/test', 03:15:55 INFO - 'SHELL': '/bin/bash', 03:15:55 INFO - 'SHLVL': '1', 03:15:55 INFO - 'TERM': 'linux', 03:15:55 INFO - 'TMOUT': '86400', 03:15:55 INFO - 'USER': 'cltbld', 03:15:55 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', 03:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:55 INFO - '_': '/tools/buildbot/bin/python'} 03:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:56 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 03:15:56 INFO - Cleaning up... 03:15:56 INFO - Return code: 0 03:15:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faa5ba68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', '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 03:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:15:56 INFO - Using env: {'DISPLAY': ':0', 03:15:56 INFO - 'HOME': '/home/cltbld', 03:15:56 INFO - 'LANG': 'en_US.UTF-8', 03:15:56 INFO - 'LANGUAGE': 'en_US:en', 03:15:56 INFO - 'LOGNAME': 'cltbld', 03:15:56 INFO - 'MAIL': '/var/mail/cltbld', 03:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:56 INFO - 'MOZ_NO_REMOTE': '1', 03:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:56 INFO - 'NO_EM_RESTART': '1', 03:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:56 INFO - 'PWD': '/builds/slave/test', 03:15:56 INFO - 'SHELL': '/bin/bash', 03:15:56 INFO - 'SHLVL': '1', 03:15:56 INFO - 'TERM': 'linux', 03:15:56 INFO - 'TMOUT': '86400', 03:15:56 INFO - 'USER': 'cltbld', 03:15:56 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', 03:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:56 INFO - '_': '/tools/buildbot/bin/python'} 03:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:56 INFO - Downloading/unpacking psutil>=0.7.1 03:15: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 03:15: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 03:15: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 03:15: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 03:15: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 03:15: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 03:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:15:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:58 INFO - Installing collected packages: psutil 03:15:58 INFO - Running setup.py install for psutil 03:15:58 INFO - building 'psutil._psutil_linux' extension 03:15:58 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 03:15:58 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 03:15:58 INFO - building 'psutil._psutil_posix' extension 03:15:58 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 03:15:58 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 03:15:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:58 INFO - Successfully installed psutil 03:15:58 INFO - Cleaning up... 03:15:58 INFO - Return code: 0 03:15:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:15:58 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')]} 03:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:58 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')]} 03:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:58 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 0x7faa5ba68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', '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 03:15:58 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 03:15:58 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 03:15:58 INFO - Using env: {'DISPLAY': ':0', 03:15:58 INFO - 'HOME': '/home/cltbld', 03:15:58 INFO - 'LANG': 'en_US.UTF-8', 03:15:58 INFO - 'LANGUAGE': 'en_US:en', 03:15:58 INFO - 'LOGNAME': 'cltbld', 03:15:58 INFO - 'MAIL': '/var/mail/cltbld', 03:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:58 INFO - 'MOZ_NO_REMOTE': '1', 03:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:58 INFO - 'NO_EM_RESTART': '1', 03:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:58 INFO - 'PWD': '/builds/slave/test', 03:15:58 INFO - 'SHELL': '/bin/bash', 03:15:58 INFO - 'SHLVL': '1', 03:15:58 INFO - 'TERM': 'linux', 03:15:58 INFO - 'TMOUT': '86400', 03:15:58 INFO - 'USER': 'cltbld', 03:15:58 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', 03:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:58 INFO - '_': '/tools/buildbot/bin/python'} 03:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:15: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 03:15: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 03:15: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 03:15: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 03:15: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 03:15: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 03:16:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:16:01 INFO - Installing collected packages: mozsystemmonitor 03:16:01 INFO - Running setup.py install for mozsystemmonitor 03:16:01 INFO - Successfully installed mozsystemmonitor 03:16:01 INFO - Cleaning up... 03:16:01 INFO - Return code: 0 03:16:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:16: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')]} 03:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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')]} 03:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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', '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 0x7faa5ba68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', '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 03:16: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:16: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 blobuploader==1.2.4 03:16:01 INFO - Using env: {'DISPLAY': ':0', 03:16:01 INFO - 'HOME': '/home/cltbld', 03:16:01 INFO - 'LANG': 'en_US.UTF-8', 03:16:01 INFO - 'LANGUAGE': 'en_US:en', 03:16:01 INFO - 'LOGNAME': 'cltbld', 03:16:01 INFO - 'MAIL': '/var/mail/cltbld', 03:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:01 INFO - 'MOZ_NO_REMOTE': '1', 03:16:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:01 INFO - 'NO_EM_RESTART': '1', 03:16:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:01 INFO - 'PWD': '/builds/slave/test', 03:16:01 INFO - 'SHELL': '/bin/bash', 03:16:01 INFO - 'SHLVL': '1', 03:16:01 INFO - 'TERM': 'linux', 03:16:01 INFO - 'TMOUT': '86400', 03:16:01 INFO - 'USER': 'cltbld', 03:16:01 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', 03:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:01 INFO - '_': '/tools/buildbot/bin/python'} 03:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:01 INFO - Downloading/unpacking blobuploader==1.2.4 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:03 INFO - Downloading blobuploader-1.2.4.tar.gz 03:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:16:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:16:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:03 INFO - Downloading docopt-0.6.1.tar.gz 03:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:16:04 INFO - Installing collected packages: blobuploader, requests, docopt 03:16:04 INFO - Running setup.py install for blobuploader 03:16:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:16:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:16:04 INFO - Running setup.py install for requests 03:16:04 INFO - Running setup.py install for docopt 03:16:04 INFO - Successfully installed blobuploader requests docopt 03:16:04 INFO - Cleaning up... 03:16:04 INFO - Return code: 0 03:16:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:04 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 0x7faa5ba68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', '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 03:16:04 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 03:16:04 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 03:16:04 INFO - Using env: {'DISPLAY': ':0', 03:16:04 INFO - 'HOME': '/home/cltbld', 03:16:04 INFO - 'LANG': 'en_US.UTF-8', 03:16:04 INFO - 'LANGUAGE': 'en_US:en', 03:16:04 INFO - 'LOGNAME': 'cltbld', 03:16:04 INFO - 'MAIL': '/var/mail/cltbld', 03:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:04 INFO - 'MOZ_NO_REMOTE': '1', 03:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:04 INFO - 'NO_EM_RESTART': '1', 03:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:04 INFO - 'PWD': '/builds/slave/test', 03:16:04 INFO - 'SHELL': '/bin/bash', 03:16:04 INFO - 'SHLVL': '1', 03:16:04 INFO - 'TERM': 'linux', 03:16:04 INFO - 'TMOUT': '86400', 03:16:04 INFO - 'USER': 'cltbld', 03:16:04 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', 03:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:04 INFO - '_': '/tools/buildbot/bin/python'} 03:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:04 INFO - Running setup.py (path:/tmp/pip-GWt2YJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:04 INFO - Running setup.py (path:/tmp/pip-GeEADE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:04 INFO - Running setup.py (path:/tmp/pip-4vvrjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:05 INFO - Running setup.py (path:/tmp/pip-kShPxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:05 INFO - Running setup.py (path:/tmp/pip-3iLK5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:05 INFO - Running setup.py (path:/tmp/pip-kszivB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:05 INFO - Running setup.py (path:/tmp/pip-r8xgay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:05 INFO - Running setup.py (path:/tmp/pip-NWoTVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:05 INFO - Running setup.py (path:/tmp/pip-6mtBqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:05 INFO - Running setup.py (path:/tmp/pip-oasYqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:05 INFO - Running setup.py (path:/tmp/pip-5saNXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:05 INFO - Running setup.py (path:/tmp/pip-BVFiYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:05 INFO - Running setup.py (path:/tmp/pip-dwM8Ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:05 INFO - Running setup.py (path:/tmp/pip-QfikvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:05 INFO - Running setup.py (path:/tmp/pip-aI9iFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:05 INFO - Running setup.py (path:/tmp/pip-J26wxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:05 INFO - Running setup.py (path:/tmp/pip-eOF2Xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:16:06 INFO - Running setup.py install for manifestparser 03:16:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Running setup.py install for mozcrash 03:16:06 INFO - Running setup.py install for mozdebug 03:16:06 INFO - Running setup.py install for mozdevice 03:16:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Running setup.py install for mozfile 03:16:06 INFO - Running setup.py install for mozhttpd 03:16:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Running setup.py install for mozinfo 03:16:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Running setup.py install for mozInstall 03:16:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:16:06 INFO - Running setup.py install for mozleak 03:16:06 INFO - Running setup.py install for mozlog 03:16:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:16:07 INFO - Running setup.py install for moznetwork 03:16:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:16:07 INFO - Running setup.py install for mozprocess 03:16:07 INFO - Running setup.py install for mozprofile 03:16:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:16:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:16:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:16:07 INFO - Running setup.py install for mozrunner 03:16:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:16:07 INFO - Running setup.py install for mozscreenshot 03:16:07 INFO - Running setup.py install for moztest 03:16:07 INFO - Running setup.py install for mozversion 03:16:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:16:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:16:07 INFO - Cleaning up... 03:16:07 INFO - Return code: 0 03:16:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:07 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')]} 03:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:07 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')]} 03:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:07 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 0x7faa5ba68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', '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 03:16:07 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 03:16:07 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 03:16:07 INFO - Using env: {'DISPLAY': ':0', 03:16:07 INFO - 'HOME': '/home/cltbld', 03:16:07 INFO - 'LANG': 'en_US.UTF-8', 03:16:07 INFO - 'LANGUAGE': 'en_US:en', 03:16:07 INFO - 'LOGNAME': 'cltbld', 03:16:07 INFO - 'MAIL': '/var/mail/cltbld', 03:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:07 INFO - 'MOZ_NO_REMOTE': '1', 03:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:07 INFO - 'NO_EM_RESTART': '1', 03:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:07 INFO - 'PWD': '/builds/slave/test', 03:16:07 INFO - 'SHELL': '/bin/bash', 03:16:07 INFO - 'SHLVL': '1', 03:16:07 INFO - 'TERM': 'linux', 03:16:07 INFO - 'TMOUT': '86400', 03:16:07 INFO - 'USER': 'cltbld', 03:16:07 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', 03:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:07 INFO - '_': '/tools/buildbot/bin/python'} 03:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:08 INFO - Running setup.py (path:/tmp/pip-UBRzoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:08 INFO - Running setup.py (path:/tmp/pip-td16S7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:08 INFO - Running setup.py (path:/tmp/pip-5RQPH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:08 INFO - Running setup.py (path:/tmp/pip-KJQwMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:08 INFO - Running setup.py (path:/tmp/pip-qnXD5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:08 INFO - Running setup.py (path:/tmp/pip-R43wVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:08 INFO - Running setup.py (path:/tmp/pip-uh5fXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:08 INFO - Running setup.py (path:/tmp/pip-UYvGiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:08 INFO - Running setup.py (path:/tmp/pip-rAJ3Rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:08 INFO - Running setup.py (path:/tmp/pip-1hSHgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:08 INFO - Running setup.py (path:/tmp/pip-SB77tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:08 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)) 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:08 INFO - Running setup.py (path:/tmp/pip-I09heU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:09 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)) 03:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:09 INFO - Running setup.py (path:/tmp/pip-RZQBL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:09 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)) 03:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:09 INFO - Running setup.py (path:/tmp/pip-RCHvRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:09 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)) 03:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:09 INFO - Running setup.py (path:/tmp/pip-GGWLtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:09 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)) 03:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:09 INFO - Running setup.py (path:/tmp/pip-0HZHBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:09 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)) 03:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:09 INFO - Running setup.py (path:/tmp/pip-LSKeRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:09 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)) 03:16:09 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)) 03:16:09 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)) 03:16:09 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)) 03:16:09 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)) 03:16:09 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)) 03:16:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:16:09 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 03:16:09 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 03:16:09 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 03:16:09 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 03:16:09 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 03:16:09 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 03:16:11 INFO - Downloading blessings-1.6.tar.gz 03:16:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:16:11 INFO - Installing collected packages: blessings 03:16:11 INFO - Running setup.py install for blessings 03:16:11 INFO - Successfully installed blessings 03:16:11 INFO - Cleaning up... 03:16:11 INFO - Return code: 0 03:16:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:11 INFO - Reading from file tmpfile_stdout 03:16:11 INFO - Current package versions: 03:16:11 INFO - argparse == 1.2.1 03:16:11 INFO - blessings == 1.6 03:16:11 INFO - blobuploader == 1.2.4 03:16:11 INFO - docopt == 0.6.1 03:16:11 INFO - manifestparser == 1.1 03:16:11 INFO - mozInstall == 1.12 03:16:11 INFO - mozcrash == 0.17 03:16:11 INFO - mozdebug == 0.1 03:16:11 INFO - mozdevice == 0.48 03:16:11 INFO - mozfile == 1.2 03:16:11 INFO - mozhttpd == 0.7 03:16:11 INFO - mozinfo == 0.9 03:16:11 INFO - mozleak == 0.1 03:16:11 INFO - mozlog == 3.1 03:16:11 INFO - moznetwork == 0.27 03:16:11 INFO - mozprocess == 0.22 03:16:11 INFO - mozprofile == 0.28 03:16:11 INFO - mozrunner == 6.11 03:16:11 INFO - mozscreenshot == 0.1 03:16:11 INFO - mozsystemmonitor == 0.0 03:16:11 INFO - moztest == 0.7 03:16:11 INFO - mozversion == 1.4 03:16:11 INFO - psutil == 3.1.1 03:16:11 INFO - requests == 1.2.3 03:16:11 INFO - wsgiref == 0.1.2 03:16:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:11 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 0x7faa5ba68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', '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 03:16:11 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 03:16:11 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 03:16:11 INFO - Using env: {'DISPLAY': ':0', 03:16:11 INFO - 'HOME': '/home/cltbld', 03:16:11 INFO - 'LANG': 'en_US.UTF-8', 03:16:11 INFO - 'LANGUAGE': 'en_US:en', 03:16:11 INFO - 'LOGNAME': 'cltbld', 03:16:11 INFO - 'MAIL': '/var/mail/cltbld', 03:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:11 INFO - 'MOZ_NO_REMOTE': '1', 03:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:11 INFO - 'NO_EM_RESTART': '1', 03:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:11 INFO - 'PWD': '/builds/slave/test', 03:16:11 INFO - 'SHELL': '/bin/bash', 03:16:11 INFO - 'SHLVL': '1', 03:16:11 INFO - 'TERM': 'linux', 03:16:11 INFO - 'TMOUT': '86400', 03:16:11 INFO - 'USER': 'cltbld', 03:16:11 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', 03:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:11 INFO - '_': '/tools/buildbot/bin/python'} 03:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:11 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)) 03:16:11 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)) 03:16:11 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)) 03:16:11 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)) 03:16:11 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)) 03:16:11 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)) 03:16:11 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)) 03:16:11 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)) 03:16:11 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)) 03:16:11 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)) 03:16:11 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)) 03:16:11 INFO - Cleaning up... 03:16:11 INFO - Return code: 0 03:16:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:11 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 0x7faa5ba68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', '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 03:16:11 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 03:16:11 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 03:16:11 INFO - Using env: {'DISPLAY': ':0', 03:16:11 INFO - 'HOME': '/home/cltbld', 03:16:11 INFO - 'LANG': 'en_US.UTF-8', 03:16:11 INFO - 'LANGUAGE': 'en_US:en', 03:16:11 INFO - 'LOGNAME': 'cltbld', 03:16:11 INFO - 'MAIL': '/var/mail/cltbld', 03:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:11 INFO - 'MOZ_NO_REMOTE': '1', 03:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:11 INFO - 'NO_EM_RESTART': '1', 03:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:11 INFO - 'PWD': '/builds/slave/test', 03:16:11 INFO - 'SHELL': '/bin/bash', 03:16:11 INFO - 'SHLVL': '1', 03:16:11 INFO - 'TERM': 'linux', 03:16:11 INFO - 'TMOUT': '86400', 03:16:11 INFO - 'USER': 'cltbld', 03:16:11 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', 03:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:11 INFO - '_': '/tools/buildbot/bin/python'} 03:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:12 INFO - Downloading/unpacking jsonschema 03:16:12 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 03:16:12 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 03:16:12 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 03:16:12 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 03:16:12 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 03:16:12 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 03:16:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:16:14 INFO - Downloading/unpacking functools32 (from jsonschema) 03:16:14 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 03:16:14 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 03:16:14 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 03:16:14 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 03:16:14 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 03:16:14 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 03:16:14 INFO - Downloading functools32-3.2.3-2.tar.gz 03:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:16:14 INFO - warning: no files found matching '*.txt' 03:16:14 INFO - no previously-included directories found matching 'build' 03:16:14 INFO - no previously-included directories found matching 'dist' 03:16:14 INFO - no previously-included directories found matching '.git*' 03:16:14 INFO - Installing collected packages: jsonschema, functools32 03:16:14 INFO - Running setup.py install for functools32 03:16:14 INFO - warning: no files found matching '*.txt' 03:16:14 INFO - no previously-included directories found matching 'build' 03:16:14 INFO - no previously-included directories found matching 'dist' 03:16:14 INFO - no previously-included directories found matching '.git*' 03:16:14 INFO - Successfully installed jsonschema functools32 03:16:14 INFO - Cleaning up... 03:16:14 INFO - Return code: 0 03:16:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:14 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 0x7faa5ba68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28575a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', '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 03:16:14 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 03:16:14 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 03:16:14 INFO - Using env: {'DISPLAY': ':0', 03:16:14 INFO - 'HOME': '/home/cltbld', 03:16:14 INFO - 'LANG': 'en_US.UTF-8', 03:16:14 INFO - 'LANGUAGE': 'en_US:en', 03:16:14 INFO - 'LOGNAME': 'cltbld', 03:16:14 INFO - 'MAIL': '/var/mail/cltbld', 03:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:14 INFO - 'MOZ_NO_REMOTE': '1', 03:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:14 INFO - 'NO_EM_RESTART': '1', 03:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:14 INFO - 'PWD': '/builds/slave/test', 03:16:14 INFO - 'SHELL': '/bin/bash', 03:16:14 INFO - 'SHLVL': '1', 03:16:14 INFO - 'TERM': 'linux', 03:16:14 INFO - 'TMOUT': '86400', 03:16:14 INFO - 'USER': 'cltbld', 03:16:14 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', 03:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:14 INFO - '_': '/tools/buildbot/bin/python'} 03:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:14 INFO - Downloading/unpacking flake8 03:16:14 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 03:16:14 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 03:16:14 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 03:16:14 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 03:16:14 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 03:16:14 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 03:16:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:16:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:16:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:16:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:16:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:16:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:16:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:16:17 INFO - no previously-included directories found matching 'docs/_build' 03:16:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:16:17 INFO - Running setup.py install for pep8 03:16:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:16:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:16:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:16:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:16:17 INFO - no previously-included directories found matching 'docs/_build' 03:16:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:16:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:16:17 INFO - Cleaning up... 03:16:17 INFO - Return code: 0 03:16:17 INFO - Running post-action listener: _resource_record_post_action 03:16:17 INFO - Running post-action listener: _start_resource_monitoring 03:16:17 INFO - Starting resource monitoring. 03:16:17 INFO - ##### 03:16:17 INFO - ##### Running install step. 03:16:17 INFO - ##### 03:16:17 INFO - Running pre-action listener: _resource_record_pre_action 03:16:17 INFO - Running main action method: install 03:16:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:17 INFO - Reading from file tmpfile_stdout 03:16:17 INFO - Detecting whether we're running mozinstall >=1.0... 03:16:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:16:17 INFO - Reading from file tmpfile_stdout 03:16:17 INFO - Output received: 03:16:17 INFO - Usage: mozinstall [options] installer 03:16:17 INFO - Options: 03:16:17 INFO - -h, --help show this help message and exit 03:16:17 INFO - -d DEST, --destination=DEST 03:16:17 INFO - Directory to install application into. [default: 03:16:17 INFO - "/builds/slave/test"] 03:16:17 INFO - --app=APP Application being installed. [default: firefox] 03:16:17 INFO - mkdir: /builds/slave/test/build/application 03:16:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:16:33 INFO - Reading from file tmpfile_stdout 03:16:33 INFO - Output received: 03:16:33 INFO - /builds/slave/test/build/application/firefox/firefox 03:16:33 INFO - Running post-action listener: _resource_record_post_action 03:16:33 INFO - ##### 03:16:33 INFO - ##### Running run-tests step. 03:16:33 INFO - ##### 03:16:33 INFO - Running pre-action listener: _resource_record_pre_action 03:16:33 INFO - Running main action method: run_tests 03:16:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:16:33 INFO - Python 2.7.3 03:16:33 INFO - Return code: 0 03:16:33 INFO - grabbing minidump binary from tooltool 03:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:33 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 0x28e6410>, '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 0x28e7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e77a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:16:33 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 03:16:33 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 03:16:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:16:33 INFO - Return code: 0 03:16:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:16:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:16:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:16:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:16:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:16:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:16:34 INFO - Return code: 0 03:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 03:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 03:16:34 INFO - Using env: {'DISPLAY': ':0', 03:16:34 INFO - 'HOME': '/home/cltbld', 03:16:34 INFO - 'LANG': 'en_US.UTF-8', 03:16:34 INFO - 'LANGUAGE': 'en_US:en', 03:16:34 INFO - 'LOGNAME': 'cltbld', 03:16:34 INFO - 'MAIL': '/var/mail/cltbld', 03:16:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:16:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:34 INFO - 'MOZ_NO_REMOTE': '1', 03:16:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:34 INFO - 'NO_EM_RESTART': '1', 03:16:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:34 INFO - 'PWD': '/builds/slave/test', 03:16:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:16:34 INFO - 'SHELL': '/bin/bash', 03:16:34 INFO - 'SHLVL': '1', 03:16:34 INFO - 'TERM': 'linux', 03:16:34 INFO - 'TMOUT': '86400', 03:16:34 INFO - 'USER': 'cltbld', 03:16:34 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770', 03:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:34 INFO - '_': '/tools/buildbot/bin/python'} 03:16:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 03:16:34 INFO - mozversion application_buildid: 20160505123841 03:16:34 INFO - mozversion application_changeset: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b 03:16:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:16:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:16:34 INFO - mozversion application_name: Firefox 03:16:34 INFO - mozversion application_remotingname: firefox-dev 03:16:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:16:34 INFO - mozversion application_vendor: Mozilla 03:16:34 INFO - mozversion application_version: 48.0a2 03:16:34 INFO - mozversion platform_buildid: 20160505123841 03:16:34 INFO - mozversion platform_changeset: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b 03:16:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:16:34 INFO - mozversion platform_version: 48.0a2 03:16:34 INFO - using testdate: 1462529794 03:16:34 INFO - actual date: 1462529794 03:16:34 INFO - starting webserver on 'localhost:50200' 03:16:34 INFO - SUITE-START | Running 2 tests 03:16:34 INFO - TEST-START | dromaeo_css 03:16:34 INFO - operating with platform_type : linux_ 03:16:34 INFO - Initialising browser for dromaeo_css test... 03:16:34 INFO - TEST-INFO | started process 960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeGQOJh/profile http://localhost:50200/getInfo.html) 03:16:38 INFO - PROCESS | 960 | __metrics Screen width/height:1600/1200 03:16:38 INFO - PROCESS | 960 | colorDepth:24 03:16:38 INFO - PROCESS | 960 | Browser inner width/height: 1024/697 03:16:38 INFO - PROCESS | 960 | __metrics 03:16:39 ERROR - PROCESS | 960 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:16:40 INFO - TEST-INFO | 960: exit 0 03:16:40 INFO - Browser initialized. 03:16:40 INFO - Running cycle 1/1 for dromaeo_css test... 03:16:40 INFO - TEST-INFO | started process 1058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeGQOJh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:52 INFO - PROCESS | 1058 | RSS: Main: 141643776 03:16:52 INFO - PROCESS | 1058 | 03:17:43 INFO - PROCESS | 1058 | 1462529863329 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] 03:19:50 INFO - PROCESS | 1058 | Cycle 1(1): loaded http://localhost:50200/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50200/tests/dromaeo/cssquery-ext.html) 03:19:51 INFO - PROCESS | 1058 | RSS: Main: 251568128 03:19:51 INFO - PROCESS | 1058 | 03:22:54 INFO - PROCESS | 1058 | Cycle 1(1): loaded http://localhost:50200/tests/dromaeo/cssquery-ext.html (next: http://localhost:50200/tests/dromaeo/cssquery-jquery.html) 03:22:54 INFO - PROCESS | 1058 | RSS: Main: 223469568 03:22:54 INFO - PROCESS | 1058 | 03:25:56 INFO - PROCESS | 1058 | Cycle 1(1): loaded http://localhost:50200/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50200/tests/dromaeo/cssquery-mootools.html) 03:25:57 INFO - PROCESS | 1058 | RSS: Main: 220635136 03:25:57 INFO - PROCESS | 1058 | 03:28:59 INFO - PROCESS | 1058 | Cycle 1(1): loaded http://localhost:50200/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50200/tests/dromaeo/cssquery-prototype.html) 03:28:59 INFO - PROCESS | 1058 | RSS: Main: 215613440 03:28:59 INFO - PROCESS | 1058 | 03:32:02 INFO - PROCESS | 1058 | Cycle 1(1): loaded http://localhost:50200/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50200/tests/dromaeo/cssquery-yui.html) 03:32:02 INFO - PROCESS | 1058 | RSS: Main: 214200320 03:32:02 INFO - PROCESS | 1058 | 03:35:05 INFO - PROCESS | 1058 | Cycle 1(1): loaded http://localhost:50200/tests/dromaeo/cssquery-yui.html (next: http://localhost:50200/tests/dromaeo/cssquery-dojo.html) 03:35:05 INFO - PROCESS | 1058 | RSS: Main: 255643648 03:35:05 INFO - PROCESS | 1058 | 03:35:05 INFO - PROCESS | 1058 | __start_tp_report 03:35:05 INFO - PROCESS | 1058 | _x_x_mozilla_page_load 03:35:05 INFO - PROCESS | 1058 | _x_x_mozilla_page_load_details 03:35:05 INFO - PROCESS | 1058 | |i|pagename|runs| 03:35:05 INFO - PROCESS | 1058 | |0;dojo.html;3308.652591477895;3347.39746845568;3364.0748794081624;3367.9326413471745;3401.523786669866;5518.337799464065;5526.50261476467;5526.861828454291;5528.198411230369;5546.334439867216;5527.143292789614;5548.44515548445;5550.69471179086;5550.8057217997375;5552.5280351170095;4884;5014.072396606631;5030.6730062546;5094.261332106842;5101.872453188681;4937.333459982892;5019.623528235379;5021.096202683516;5025.924611130836;5026.84919452417;5026.547610715035;5065.290859279704;5128.692278463304;5139.177731562932;5171.301874246985;5090.33825602673;5120.769565369567;5128.666636668605;5130;5159.58723302135;4854.757262136879;4936.654434189608;5030.044291584587;5037.471065538102;5046.7476626168545;5365.195220716884;5402.486763757437;5408.215808707715;5408.945910540883;5435.211894275308;5787.450192231773;5811.982902992002;5812.302523697141;5814.97092514539;5818.185454036438;5845.503132233765;5848.122781582754;5923.496502797268;5955.910661340084;5977;5552.361478429952;5563.944360556424;5586.608937374426;5595.38450770415;5604.215409842666;5928.79249226275;6060.212172417646;6069.393060693984;6079.756809727562;6080.179175811298;5765.798197063083;5834.241548598655;5844.12338149281;5845.824625261249;5847.356790753014;5866.560007999417;5881.117832325185;5881.941180588225;5881.9705901470215;5891.617044892154;5758.193852860602;5842.298924129047;5843.3864444233595;5849.64902105875;5867.090600956859;5882.3529411764675;5886.793962211388;5896.086106653475;5896.351401345849;5920;4491.708038977456;4494.101179763995;4494.280915053576;4499.572540608637;4522.706024108423;3968.523777146703;4024.69814763888;4036.1927614476635;4073.327900896378;4079.1025974286204;5614.466625670555;5639.43605639441;5641.52047075995;5643.125315576092;5662.207290979266;5930.140129681172;5938.643681379045;5946.10808378738;5947.6431414115295;5950.464458198783;5455.290812194389;5520.1167813149705;5612.102063669875;5627.43725627434;5649.0396632572565;5036.571891389273;5074.517920797518;5076.7207803571155;5078.492150784892;5079.111155547765;6105.511559075263;6105.8168254952425;6106.053561697944;6108.877822443526;6109.877802443926;5756.856078598153;5904.232449781501;5973.761049557969;5992.280926288873;6015.218021657157;6008.459238668541;6053.636781793107;6059.6364218147055;6062.757489700362;6065.6663883486835;5636.098224284095;5726.112452569859;5733.885322293614;5740.282464691913;5743.655380677173;5840.1531777892815;5859.882802344015;5880.911786323294;5882.205902203319;5902.144189092472;5787.710614469344;5794.478496935296;5797.188393624981;5827.79602713903;5836.066229403275;5630.0991841305195;5760.884782304247;5794.420557944172;5806.82579522615;5811.070228763378;5646.548276137982;5668.574856885668;5673.035583950656;5673.290838645169;5708.80019199326;5752.28096487939;5773.74018169175;5776.364599893925;5776.942230577641;5783.508401785727;5561.888762224814;5653.491185793298;5676.432356764456;5692.943070569241;5774.884502310014 03:35:05 INFO - PROCESS | 1058 | |1;ext.html;658.1246941567715;667.2393471442559;670.3899451499137;685.3557655803544;749.3892477630731;32211.35577288453;40043.599564004355;41009.38485922714;41144;41206.58793412065;43258;43911.78044109783;43936.780316098375;43944.56055439445;43968.78015609925;8675.60959756811;8895.599698013604;8896.599653015597;8900.910990890105;8906.42108262964;8363.247307742302;8461.703840365588;8485.61814718336;8488.108748581371;8655.17775811297;8724;8746.125387461234;8747.825043499159;8748.475091494498;8756.60595273211;8682.956585217065;8706.347023973227;8708.738737837875;8710.651573937066;8710.69512567057;8723.694670686495;8826.602802873886;8827.911720882774;8829.16122968317;9060.139286767746;43825.34261986073;44271.335929961075;44277.55722442766;44366.33450498245;44436.77781611071;3933.9016524586827;3964.7621142731527;4049.5950404959563;4141.964508872782;4331.7834108294455;34192.82903585466;34353.31293374119;34475;34772.30455390903;36313.27373452543;4469.374287599739;4473.888152796174;4475.77621118946;4523.2988886722615;4584.977075114603;325241;325617;327152;327570;330172.7930882762;38723.2255354897;38994;61048.38951610516;61235;61635.38364616296;40164.19671606552;40290.395644065364;40295.19409611791;40316.59683403187;40325;17100.657986840193;17333.91333043352;17354.566135846704;17355.739663905053;17366;14499.420023199165;14567.854321456862;14605.123692578267;14607.19660418687;14617.415303387957;9510.762230944143;9547.236221102296;9560.187384072431;9575.760605984768;9648.71053868385;3658.579263384692;3677.8528858845348;3679.466477360821;3683.4106542953;3734.327820992193;1107.5514416661103;1146.7993101207421;1190.8928196462186;1220.2251570252777;1237.3998610673816;34373;34441.483377749355;34633.826830866186;34761;34967;1208.1482554798845;1284.9743005139844;1318.953836615714;1322.6759443936105;1331.7136815584695;18176.56954578491;18311.63376732458;18399.90800046018;18507.629847402975;18603.255869765057;554553;564718;568970;572171;574668;62606;62707.6864615674;63159;63254;63379.36620633735;1495.6634757179547;1508.057464084947;1530.3878448620642;1533.9693206136037;1559.7894284271706;30163.095107145942;32515.18712032218;33559.66440335663;33600.15999599932;34057.65942340545;48863;49525.75237123791;49532;49539.752301238266;49564;315327;317285;320745;321788;322072;25567.105151319614;30595.54106688357;44758.77620611876;44842;46127.53872461232;48850.75574622104;49523.50476495189;49832.25251621156;50074.248886267465;50312.245316321016;42323.57676423196;42587;42658.78670606627;42819.785901070296;43945.12109757723;44114.95897160816;44623.77688111539;44720.10559788721;46035.76982115202;46710.76644616755;46724;47755;47806;48526.5147348522;48989.510104898494;40180.598194017686;40823.38764918588;41132.383014254214;41159.1768164629;41646.58353416427;31061.8446907764;31488.685113148575;31513.52729709102;31517.684823151474;32274.677253228107 03:35:05 INFO - PROCESS | 1058 | |2;jquery.html;418.63369551642324;421.20602663978394;427.7027465911193;429.7056516286342;432.35578987308907;18427.631447371044;18523.981181035055;19013.144408501616;19128.808711912876;19194.328198513056;18586.907065464653;18712.532186695305;19716.112774925128;19740.111694973726;19762.703559446585;5428.104362780146;5769.682667453289;5786.045302525078;5790.68151251681;5794.62334948227;5524.696141712204;5701.287339082614;5738.856528586777;5745.683987380692;5748.367679555246;5735.4551317624755;5759.308882934054;5763.135529670562;5768.769249230026;5770.653760774367;5515.4760297771645;5732.5987180897355;5733.254676892019;5736.225609542721;5738.139279108125;5121.078205922932;5137.537621614073;5143.434222235551;5155.587552995751;5161.587073034186;18098.819011809977;21782.89108554463;21815.45461363463;22387;22419.775802242097;2311.526137141882;2427.4659574893494;2483.615039668854;2541.542522345977;2579;9797.461139637317;9974.351667141686;10017.799644007151;10062.195024398105;13472.5284615038;1994.3917105282883;2033.2070492507933;2038.6534289170877;2095.863768855035;2132.040581738224;82183.58908205481;90482.09517904803;90778.09221907762;91361.54319228428;92323;10813.513391897384;11065.446727663584;11147.665570032912;11296.6046188383;11335.263207891461;16068.634166095779;16134;16173.838261617468;16222.594435139215;16227.107509087113;7925.207479252029;8058.874890856929;8060.596970151469;8246.257836794717;8252.257296843192;7790.220977902164;7836.098848632366;7869.173736757558;7910.090339611018;7925.722599708983;4877.707337559757;4906.533879281463;4917.950820491821;4928.383952005999;5118.413291879529;2003.3188715836686;2010.3164923925935;2051.8153366197116;2069.317125348631;2095.4656562576447;986.1666891476691;1066.1204506282193;1147.8794726553592;1159.4666453431516;1171.5606647507184;18285.63428731418;18691.252349906124;18989;19177;19471;1062.5802807890839;1074.8065348237392;1086.6957251969461;1151.6026970695098;1161.9128565357462;10335.276530642783;10660.520276587573;10723.19576031785;10826.458677066115;10865.51105200268;499315;500966;504407;507738;509564;102705.48647256717;107609;107876;109506.45246773715;109654;1101.983470247947;1125;1135.1543100390097;1148.7013376522164;1158.5481662151767;16952.915235423745;17015.65968680644;17134.571635709206;17282.827171728626;17603.29586816513;37674.62325376821;38920.22159556737;42482.36276455918;43726.78136609297;44434.55565444433;56663.433365667464;59723;59906.40093599183;60515.092273616814;61025;8260.917390826015;8414.368922330972;8633.525156116473;8644.956775216335;9021.097890210927;9232.076792320715;12785.61643150707;12888.162269452456;13140.0801943863;13643.86356136426;11763.882361176278;11790.528378864748;11949.22330048544;12041.09691773103;12152.270863748203;11793.823092653789;12232.755344892874;12295.139340246096;12406.379681016093;12712.809307860205;11975.520979160736;12165.513379464723;12675.873241267469;12703.237805731686;12728.751525010137;8277.84110224557;8412.915870841212;8795.25240354577;8839.425437346552;9248.21390181842;8463.984321881413;11387.772244555228;11848.70378240551;11904;12158.209716368408 03:35:05 INFO - PROCESS | 1058 | |3;mootools.html;1393.8466768655453;1568.4588816858184;1584.8811339149563;1782.572182676158;1872.7284543741157;8128.878066828995;8438.2827459666;8439.113893041234;8451.492910425379;8457.957710211447;8158.877616835753;8350.624221910013;8359.582020898946;8364.2472177504;8382.455140415868;2104.0531760707745;2311.087120587367;2352.8117750579954;2367.550165468564;2381.92854214373;2358.9528209435803;2368.7394386617457;2369.3484291819714;2369.763023697634;2372.4306166519996;2289.8511596746243;2335.369450248432;2337.1936681844822;2338.684277622516;2339.2748248043076;2080.7411516032807;2293.816494680422;2346.530693861235;2361.232599405183;2361.4450604108106;2249.156566287642;2249.8200143988443;2251.79733823955;2271.8750468724215;2327.104064935012;8564.272036876873;8576.44253123545;8657.26413254874;8670.349723770742;8685.565721713889;5109.846704598868;5315.468453154692;5341.946580534183;5356.54469370104;5361.919571206435;3275.3449310138067;3285.162283617686;3339.34882697874;3415.504751810998;3417.709494692929;1068.9893101069044;1073.3988966178965;1095.5508241620978;1112.1214240749798;1130.604288499027;11748.882511174865;11756.94121529387;11805;11828.585999490062;11835;4486.753228572395;4556.3621093047;4580.839670611579;4585.518520555361;4649.395578574764;10149.847752283722;10169.745756356151;10174.186065114773;10202.33684810485;10203.183745300357;4696.272077827942;5297.443768404339;5420.214068959979;5426.620136590401;5427.1316589345515;4735.668503204812;4831.661783675179;4863.1003264395495;4869.537393947569;4873.585745211626;4003.53959294679;4007.5800457756127;4099.487564054493;4107.486564179478;4127.33962565988;1250.7998720204905;1285.9357032148541;1294.5210272199347;1295.352323838081;1313.8292022037074;998.0717932323009;1015.9339642923186;1023.4780262066251;1025.3079171559168;1028.8148133336072;5729.226554415184;5769.1923130761725;5809.186713860063;5881.441263080001;5915.349311575723;445.08757048051365;448.28498544820957;448.77561219390304;1088.7495875948575;1124.5839039555253;4048.4939382577177;4058.4521089652517;4058.6753059755147;4060.918781624351;4085.571015043437;10358.741031474123;10745.14038876888;10839.295445795999;10878.020978112008;10905.18211134168;10557.155427565776;10679.466026698634;10749.731256718645;10752;10800;8274.255317021498;8383.371247156487;8432;8434.957825210835;8458.619362128842;5680.71596420169;5768.53851691872;5885.47030767233;5887;5890.352061273171;9808.607655693691;9810.705678829647;10064.849027264743;10074.8488772667;10231.079202871777;9905.455199963782;10147.238957078102;10191.388516689023;10237.48812559384;10409.219308552041;7029.507934444539;7547.358474529727;7751.604711152047;7821.804454888445;7997.680092796223;8426.241638252586;8430.83138337242;8468.44955077918;8500.787480313042;8509.74470765878;7481.588512631857;7643.656035478528;7668.961655191688;7735.883961740691;7782.2217778223985;7563.848723025619;7606.125295591078;7665.23347665229;7691.538507689556;7758.224177582197;7029.156501219886;7235.2764723529335;7275.490715650066;7281.817954551178;7285.380742636723;4795.9280610790165;4835.758212089311;4932.21084626458;5024.321716568363;5033.924491132562;4915.090708218991;5189.506996835295;5303.7082960436;5364.195370694427;5390 03:35:05 INFO - PROCESS | 1058 | |4;prototype.html;320.4488280158127;322.40516247523317;322.72890771751725;338.9271306669064;339.7689571091657;5318.521333080022;5351.4380989996025;5374.838754837357;5417.674939503623;5449.863753406157;5338.893222135555;5363.141897296433;5373.865653358658;5385.21914322423;5393.1910213468;4021.4168945502884;4081.6530594899323;4185.623293903548;4219.2616292148905;4242.172776308621;4170.186813571355;4174.519930208035;4201.327787553992;4215.913123004118;4231.746095234295;3993.361062230044;4175;4177.749335039907;4187.811548480326;4188.539260681323;4070.409790580364;4170.6871984600975;4175.331946888483;4186.518550366716;4217.894552636178;3659.8536058557625;3687.9815600922093;3704.703084087856;3707.7404581679293;3711.164987877733;5153.871153221162;5155.664881782672;5178.197379406198;5178.585713142939;5194.35070616173;4433.224185767478;4687.812487500496;4700.412448443944;4711.552402521755;4756.904861902743;5519.337679478448;5548.361938377098;5572.944270557283;5585.720713964326;5607.4112218217315;3919.392494163409;3941.4284928685465;3952.5849785772657;3955.762654240726;3968.4840970673918;5582.302212223472;5820.30156381237;5855.2187710837015;5856.297244330665;5856.355800861902;4032.6773858091283;4061.1674606705556;4066.8576599819457;4071.1043570414463;4098.73358231714;4088.6524645405475;4099.61053699898;4125.752454852718;4131.47979732363;4133.318002529549;4610.723356598614;4735.147673418749;4752.976235118871;4755.809767609257;4768.666193366431;5639.492445679908;5661.7735290588735;5667.4615911488345;5678.14827775837;5684.744186511534;1495.723291191133;1507.4045751927927;1507.4422463688286;1510.9773353399708;1512.599161222277;907.804821963281;938.8028514011997;997.6308765756717;999.5701848205341;1005.1506477026901;5752.02215623345;5782.739776710058;5793.449622285876;5801.94198058014;5814.098814683731;6094.847628809315;6096.481799047042;6121.96939015311;6122.602030867979;6131.724072416752;5298.655587386807;5581.325602319288;5595.552355811526;5615.466530679579;5779.682117483495;3302.867885284562;3303.306305675787;3303.5540202072893;3313.122022663996;3318.5354050432957;6256.217972753406;6361.173047503795;6402.8719425611225;6459.224893012774;6459.838504037437;6213.887278325301;6275.529335299871;6277.2153480814895;6302.212223472066;6335.11308416822;6265.718042688181;6425.389587989227;6431.710573024225;6440.54916155874;6473.255575608865;6183.258009038944;6191.597546159485;6196.752129914753;6211.844703882439;6242.812715618538;6144.662043587646;6163.167972323679;6169.2288463942;6183.268684768272;6185.8144255672405;5824.242848429846;5925.40745925404;6093.421124993119;6099.9390006099375;6454.419102280817;4004.939925901172;4035.596440355941;4060.1879624074713;4087.9182416350914;4099.200655872076;5743.195952566561;5831.650100993954;5884.32330282023;5889.99740088372;5901.409859014064;5742.425757424224;5761.884762304814;5764.971175144097;5766.3368712598585;5777.064683331131;5682.119271512922;5698.202251684685;5707.429257074259;5707.714614269353;5758.596898217084;5435.673859568438;5632.324121105494;5633.915491267552;5645.350784659817;5646.209530665628;5713.600167958876;5756.884862302814;5764.250647415809;5765.682887441231;5777.6822274775295;5599.188117722826;5609.635373700697;5619.325680918316;5633.943660563506;5647.774089036392 03:35:05 INFO - PROCESS | 1058 | |5;yui.html;860.2816648098838;860.6772460327377;866.7746385939656;884.8805411269481;915.6840889892984;14387.928060359696;14760.852391476083;14791.260436978162;14797.926010369933;14808.925955370209;14623;14650.19423931686;14692.191929443876;14789.40842366304;14796.55610331689;765.9502132361406;888.3470649072926;896.3680605173354;926.3237836379448;931.3713243560603;930.6742640075987;933.5565606337003;933.7105497295826;934.850423932171;935.9532023398837;792.1603100713234;952.1906379577373;976.038601977052;978.921686265097;979.304693667497;973.6738192705452;975.4439969217584;976.067855198284;976.2726768557435;978.2516374973151;719.5358993449196;720.0423436829058;721.12383454103;721.6139365439517;721.9675114619802;15201.163935983517;15242.618934526614;15289.61775955599;15318.693626127415;15344.693106137925;14765.852341476555;15198.392064317413;15456.227188640523;15462;15490.61273468161;11634.243774154738;11808.350540720257;11848.822267665906;12000.159988800788;12120.939395302967;3948.7828169450668;3953.367461206193;3990.182012687392;4005.0588111793704;4110.095778928631;52325.7383713079;52386.47613523854;52441;52962.73518632421;53037;10323.225758068174;10433.530491127918;10670;10672.25294229412;10842.457877106272;19192.520186995436;19449.8055019448;19516.31692890742;19537.804621953597;19607.509812254524;8111.351091912633;8199.918000819915;8606.44058136219;8608.95695521531;8882.467051976902;4804.591609713214;4985.476524964826;5007.924881126786;5121.103806833789;5125.666831655931;3441.8795342162903;3502.5446691930397;3505.0361150683257;3511.719062475047;3513.1392808762016;702.259116631948;723.4248772226093;725.9165196002422;726.3208899678817;726.7202127181073;763.7059732003107;780.3990926986189;793.2107552984817;820.6635279535362;829.9045609754955;10023;10054.447005414626;10088.949555252177;10108.949455252823;10129.139023182965;693.8300116471497;749.7863109014014;767.8234006178499;771.9189485104096;791.7743443118799;4606.332081848113;4652.744099074515;4690.530946905282;4769.332293478916;4797.328374027639;62022;62231.6888415555;63523.68238158872;66321;66483;53968.190477142874;55375.72312138414;56273.43726562764;56779;58536.12195817066;52588.73705631447;52651.47348526542;53237;53504.46495534995;53784.19323710148;9175.403598766059;9219.446833189762;9360.485173315534;9419.340646154704;9511.76220594463;30895.84552077225;32663.18342041468;33168;35355.64644353523;36009.21903200231;44585.77707111444;44819.77590112029;46079.76960115178;46418.53581464142;46516.30225546687;12068.698282543006;12080.39598020078;12343.135980481638;12596.622101336974;12632.873671263538;13702.93148534251;13870.167789932233;14249.002569820428;14603.196824174773;14668.413263469341;14167.220802855942;14188.148711077369;14218.857811421753;14294;14331.713365732418;13437.462501499831;13689.041767076607;13691.589252322447;13729.588112356645;13901.0964287321;12937.353132343156;13087.214767114003;13106.803397949228;13192.142510736772;13461.057725959088;11274.879504532497;11529.1929564933;11668.94165529167;11863.34751588671;11887.76224475523;11367.317960922372;11433.1996760226;11487.597934072268;11555.364454955059;11644.35956022393 03:35:05 INFO - PROCESS | 1058 | __end_tp_report 03:35:05 INFO - PROCESS | 1058 | __start_cc_report 03:35:05 INFO - PROCESS | 1058 | _x_x_mozilla_cycle_collect,900 03:35:05 INFO - PROCESS | 1058 | __end_cc_report 03:35:05 INFO - PROCESS | 1058 | __startTimestamp1462530905440__endTimestamp 03:35:05 INFO - PROCESS | 1058 | 03:35:05 INFO - PROCESS | 1058 | ------- Summary: start ------- 03:35:05 INFO - PROCESS | 1058 | Number of tests: 6 03:35:05 INFO - PROCESS | 1058 | 03:35:05 INFO - PROCESS | 1058 | [#0] dojo.html Cycles:165 Average:5484.40 Median:5673.29 stddev:596.07 (10.5%) stddev-sans-first:572.94 03:35:05 INFO - PROCESS | 1058 | Values: 3308.7 3347.4 3364.1 3367.9 3401.5 5518.3 5526.5 5526.9 5528.2 5546.3 5527.1 5548.4 5550.7 5550.8 5552.5 4884.0 5014.1 5030.7 5094.3 5101.9 4937.3 5019.6 5021.1 5025.9 5026.8 5026.5 5065.3 5128.7 5139.2 5171.3 5090.3 5120.8 5128.7 5130.0 5159.6 4854.8 4936.7 5030.0 5037.5 5046.7 5365.2 5402.5 5408.2 5408.9 5435.2 5787.5 5812.0 5812.3 5815.0 5818.2 5845.5 5848.1 5923.5 5955.9 5977.0 5552.4 5563.9 5586.6 5595.4 5604.2 5928.8 6060.2 6069.4 6079.8 6080.2 5765.8 5834.2 5844.1 5845.8 5847.4 5866.6 5881.1 5881.9 5882.0 5891.6 5758.2 5842.3 5843.4 5849.6 5867.1 5882.4 5886.8 5896.1 5896.4 5920.0 4491.7 4494.1 4494.3 4499.6 4522.7 3968.5 4024.7 4036.2 4073.3 4079.1 5614.5 5639.4 5641.5 5643.1 5662.2 5930.1 5938.6 5946.1 5947.6 5950.5 5455.3 5520.1 5612.1 5627.4 5649.0 5036.6 5074.5 5076.7 5078.5 5079.1 6105.5 6105.8 6106.1 6108.9 6109.9 5756.9 5904.2 5973.8 5992.3 6015.2 6008.5 6053.6 6059.6 6062.8 6065.7 5636.1 5726.1 5733.9 5740.3 5743.7 5840.2 5859.9 5880.9 5882.2 5902.1 5787.7 5794.5 5797.2 5827.8 5836.1 5630.1 5760.9 5794.4 5806.8 5811.1 5646.5 5668.6 5673.0 5673.3 5708.8 5752.3 5773.7 5776.4 5776.9 5783.5 5561.9 5653.5 5676.4 5692.9 5774.9 03:35:05 INFO - PROCESS | 1058 | 03:35:05 INFO - PROCESS | 1058 | [#1] ext.html Cycles:180 Average:57367.34 Median:42739.29 stddev:111644.13 (261.2%) stddev-sans-first:111876.13 03:35:05 INFO - PROCESS | 1058 | Values: 658.1 667.2 670.4 685.4 749.4 32211.4 40043.6 41009.4 41144.0 41206.6 43258.0 43911.8 43936.8 43944.6 43968.8 8675.6 8895.6 8896.6 8900.9 8906.4 8363.2 8461.7 8485.6 8488.1 8655.2 8724.0 8746.1 8747.8 8748.5 8756.6 8683.0 8706.3 8708.7 8710.7 8710.7 8723.7 8826.6 8827.9 8829.2 9060.1 43825.3 44271.3 44277.6 44366.3 44436.8 3933.9 3964.8 4049.6 4142.0 4331.8 34192.8 34353.3 34475.0 34772.3 36313.3 4469.4 4473.9 4475.8 4523.3 4585.0 325241.0 325617.0 327152.0 327570.0 330172.8 38723.2 38994.0 61048.4 61235.0 61635.4 40164.2 40290.4 40295.2 40316.6 40325.0 17100.7 17333.9 17354.6 17355.7 17366.0 14499.4 14567.9 14605.1 14607.2 14617.4 9510.8 9547.2 9560.2 9575.8 9648.7 3658.6 3677.9 3679.5 3683.4 3734.3 1107.6 1146.8 1190.9 1220.2 1237.4 34373.0 34441.5 34633.8 34761.0 34967.0 1208.1 1285.0 1319.0 1322.7 1331.7 18176.6 18311.6 18399.9 18507.6 18603.3 554553.0 564718.0 568970.0 572171.0 574668.0 62606.0 62707.7 63159.0 63254.0 63379.4 1495.7 1508.1 1530.4 1534.0 1559.8 30163.1 32515.2 33559.7 33600.2 34057.7 48863.0 49525.8 49532.0 49539.8 49564.0 315327.0 317285.0 320745.0 321788.0 322072.0 25567.1 30595.5 44758.8 44842.0 46127.5 48850.8 49523.5 49832.3 50074.2 50312.2 42323.6 42587.0 42658.8 42819.8 43945.1 44115.0 44623.8 44720.1 46035.8 46710.8 46724.0 47755.0 47806.0 48526.5 48989.5 40180.6 40823.4 41132.4 41159.2 41646.6 31061.8 31488.7 31513.5 31517.7 32274.7 03:35:05 INFO - PROCESS | 1058 | 03:35:05 INFO - PROCESS | 1058 | [#2] jquery.html Cycles:180 Average:30091.23 Median:11957.47 stddev:83622.41 (699.3%) stddev-sans-first:83827.31 03:35:05 INFO - PROCESS | 1058 | Values: 418.6 421.2 427.7 429.7 432.4 18427.6 18524.0 19013.1 19128.8 19194.3 18586.9 18712.5 19716.1 19740.1 19762.7 5428.1 5769.7 5786.0 5790.7 5794.6 5524.7 5701.3 5738.9 5745.7 5748.4 5735.5 5759.3 5763.1 5768.8 5770.7 5515.5 5732.6 5733.3 5736.2 5738.1 5121.1 5137.5 5143.4 5155.6 5161.6 18098.8 21782.9 21815.5 22387.0 22419.8 2311.5 2427.5 2483.6 2541.5 2579.0 9797.5 9974.4 10017.8 10062.2 13472.5 1994.4 2033.2 2038.7 2095.9 2132.0 82183.6 90482.1 90778.1 91361.5 92323.0 10813.5 11065.4 11147.7 11296.6 11335.3 16068.6 16134.0 16173.8 16222.6 16227.1 7925.2 8058.9 8060.6 8246.3 8252.3 7790.2 7836.1 7869.2 7910.1 7925.7 4877.7 4906.5 4918.0 4928.4 5118.4 2003.3 2010.3 2051.8 2069.3 2095.5 986.2 1066.1 1147.9 1159.5 1171.6 18285.6 18691.3 18989.0 19177.0 19471.0 1062.6 1074.8 1086.7 1151.6 1161.9 10335.3 10660.5 10723.2 10826.5 10865.5 499315.0 500966.0 504407.0 507738.0 509564.0 102705.5 107609.0 107876.0 109506.5 109654.0 1102.0 1125.0 1135.2 1148.7 1158.5 16952.9 17015.7 17134.6 17282.8 17603.3 37674.6 38920.2 42482.4 43726.8 44434.6 56663.4 59723.0 59906.4 60515.1 61025.0 8260.9 8414.4 8633.5 8645.0 9021.1 9232.1 12785.6 12888.2 13140.1 13643.9 11763.9 11790.5 11949.2 12041.1 12152.3 11793.8 12232.8 12295.1 12406.4 12712.8 11975.5 12165.5 12675.9 12703.2 12728.8 8277.8 8412.9 8795.3 8839.4 9248.2 8464.0 11387.8 11848.7 11904.0 12158.2 03:35:05 INFO - PROCESS | 1058 | 03:35:05 INFO - PROCESS | 1058 | [#3] mootools.html Cycles:180 Average:5736.75 Median:2467.76 stddev:3230.42 (130.9%) stddev-sans-first:3223.00 03:35:05 INFO - PROCESS | 1058 | Values: 1393.8 1568.5 1584.9 1782.6 1872.7 8128.9 8438.3 8439.1 8451.5 8458.0 8158.9 8350.6 8359.6 8364.2 8382.5 2104.1 2311.1 2352.8 2367.6 2381.9 2359.0 2368.7 2369.3 2369.8 2372.4 2289.9 2335.4 2337.2 2338.7 2339.3 2080.7 2293.8 2346.5 2361.2 2361.4 2249.2 2249.8 2251.8 2271.9 2327.1 8564.3 8576.4 8657.3 8670.3 8685.6 5109.8 5315.5 5341.9 5356.5 5361.9 3275.3 3285.2 3339.3 3415.5 3417.7 1069.0 1073.4 1095.6 1112.1 1130.6 11748.9 11756.9 11805.0 11828.6 11835.0 4486.8 4556.4 4580.8 4585.5 4649.4 10149.8 10169.7 10174.2 10202.3 10203.2 4696.3 5297.4 5420.2 5426.6 5427.1 4735.7 4831.7 4863.1 4869.5 4873.6 4003.5 4007.6 4099.5 4107.5 4127.3 1250.8 1285.9 1294.5 1295.4 1313.8 998.1 1015.9 1023.5 1025.3 1028.8 5729.2 5769.2 5809.2 5881.4 5915.3 445.1 448.3 448.8 1088.7 1124.6 4048.5 4058.5 4058.7 4060.9 4085.6 10358.7 10745.1 10839.3 10878.0 10905.2 10557.2 10679.5 10749.7 10752.0 10800.0 8274.3 8383.4 8432.0 8435.0 8458.6 5680.7 5768.5 5885.5 5887.0 5890.4 9808.6 9810.7 10064.8 10074.8 10231.1 9905.5 10147.2 10191.4 10237.5 10409.2 7029.5 7547.4 7751.6 7821.8 7997.7 8426.2 8430.8 8468.4 8500.8 8509.7 7481.6 7643.7 7669.0 7735.9 7782.2 7563.8 7606.1 7665.2 7691.5 7758.2 7029.2 7235.3 7275.5 7281.8 7285.4 4795.9 4835.8 4932.2 5024.3 5033.9 4915.1 5189.5 5303.7 5364.2 5390.0 03:35:05 INFO - PROCESS | 1058 | 03:35:05 INFO - PROCESS | 1058 | [#4] prototype.html Cycles:180 Average:4841.50 Median:5577.13 stddev:1469.15 (26.3%) stddev-sans-first:1433.55 03:35:05 INFO - PROCESS | 1058 | Values: 320.4 322.4 322.7 338.9 339.8 5318.5 5351.4 5374.8 5417.7 5449.9 5338.9 5363.1 5373.9 5385.2 5393.2 4021.4 4081.7 4185.6 4219.3 4242.2 4170.2 4174.5 4201.3 4215.9 4231.7 3993.4 4175.0 4177.7 4187.8 4188.5 4070.4 4170.7 4175.3 4186.5 4217.9 3659.9 3688.0 3704.7 3707.7 3711.2 5153.9 5155.7 5178.2 5178.6 5194.4 4433.2 4687.8 4700.4 4711.6 4756.9 5519.3 5548.4 5572.9 5585.7 5607.4 3919.4 3941.4 3952.6 3955.8 3968.5 5582.3 5820.3 5855.2 5856.3 5856.4 4032.7 4061.2 4066.9 4071.1 4098.7 4088.7 4099.6 4125.8 4131.5 4133.3 4610.7 4735.1 4753.0 4755.8 4768.7 5639.5 5661.8 5667.5 5678.1 5684.7 1495.7 1507.4 1507.4 1511.0 1512.6 907.8 938.8 997.6 999.6 1005.2 5752.0 5782.7 5793.4 5801.9 5814.1 6094.8 6096.5 6122.0 6122.6 6131.7 5298.7 5581.3 5595.6 5615.5 5779.7 3302.9 3303.3 3303.6 3313.1 3318.5 6256.2 6361.2 6402.9 6459.2 6459.8 6213.9 6275.5 6277.2 6302.2 6335.1 6265.7 6425.4 6431.7 6440.5 6473.3 6183.3 6191.6 6196.8 6211.8 6242.8 6144.7 6163.2 6169.2 6183.3 6185.8 5824.2 5925.4 6093.4 6099.9 6454.4 4004.9 4035.6 4060.2 4087.9 4099.2 5743.2 5831.7 5884.3 5890.0 5901.4 5742.4 5761.9 5765.0 5766.3 5777.1 5682.1 5698.2 5707.4 5707.7 5758.6 5435.7 5632.3 5633.9 5645.4 5646.2 5713.6 5756.9 5764.3 5765.7 5777.7 5599.2 5609.6 5619.3 5633.9 5647.8 03:35:05 INFO - PROCESS | 1058 | 03:35:05 INFO - PROCESS | 1058 | [#5] yui.html Cycles:180 Average:15299.83 Median:44702.78 stddev:17307.79 (38.7%) stddev-sans-first:17322.37 03:35:05 INFO - PROCESS | 1058 | Values: 860.3 860.7 866.8 884.9 915.7 14387.9 14760.9 14791.3 14797.9 14808.9 14623.0 14650.2 14692.2 14789.4 14796.6 766.0 888.3 896.4 926.3 931.4 930.7 933.6 933.7 934.9 936.0 792.2 952.2 976.0 978.9 979.3 973.7 975.4 976.1 976.3 978.3 719.5 720.0 721.1 721.6 722.0 15201.2 15242.6 15289.6 15318.7 15344.7 14765.9 15198.4 15456.2 15462.0 15490.6 11634.2 11808.4 11848.8 12000.2 12120.9 3948.8 3953.4 3990.2 4005.1 4110.1 52325.7 52386.5 52441.0 52962.7 53037.0 10323.2 10433.5 10670.0 10672.3 10842.5 19192.5 19449.8 19516.3 19537.8 19607.5 8111.4 8199.9 8606.4 8609.0 8882.5 4804.6 4985.5 5007.9 5121.1 5125.7 3441.9 3502.5 3505.0 3511.7 3513.1 702.3 723.4 725.9 726.3 726.7 763.7 780.4 793.2 820.7 829.9 10023.0 10054.4 10088.9 10108.9 10129.1 693.8 749.8 767.8 771.9 791.8 4606.3 4652.7 4690.5 4769.3 4797.3 62022.0 62231.7 63523.7 66321.0 66483.0 53968.2 55375.7 56273.4 56779.0 58536.1 52588.7 52651.5 53237.0 53504.5 53784.2 9175.4 9219.4 9360.5 9419.3 9511.8 30895.8 32663.2 33168.0 35355.6 36009.2 44585.8 44819.8 46079.8 46418.5 46516.3 12068.7 12080.4 12343.1 12596.6 12632.9 13702.9 13870.2 14249.0 14603.2 14668.4 14167.2 14188.1 14218.9 14294.0 14331.7 13437.5 13689.0 13691.6 13729.6 13901.1 12937.4 13087.2 13106.8 13192.1 13461.1 11274.9 11529.2 11668.9 11863.3 11887.8 11367.3 11433.2 11487.6 11555.4 11644.4 03:35:05 INFO - PROCESS | 1058 | -------- Summary: end -------- 03:35:05 INFO - PROCESS | 1058 | 03:35:06 INFO - TEST-INFO | 1058: exit 0 03:35:06 INFO - TEST-OK | dromaeo_css | took 1111521ms 03:35:06 INFO - TEST-START | kraken 03:35:06 INFO - operating with platform_type : linux_ 03:35:06 INFO - Initialising browser for kraken test... 03:35:06 INFO - TEST-INFO | started process 1320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHarhCY/profile http://localhost:50200/getInfo.html) 03:35:10 INFO - PROCESS | 1320 | __metrics Screen width/height:1600/1200 03:35:10 INFO - PROCESS | 1320 | colorDepth:24 03:35:10 INFO - PROCESS | 1320 | Browser inner width/height: 1024/697 03:35:10 INFO - PROCESS | 1320 | __metrics 03:35:11 ERROR - PROCESS | 1320 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:35:12 INFO - TEST-INFO | 1320: exit 0 03:35:12 INFO - Browser initialized. 03:35:12 INFO - Running cycle 1/1 for kraken test... 03:35:12 INFO - TEST-INFO | started process 1411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHarhCY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:24 INFO - PROCESS | 1411 | RSS: Main: 142131200 03:35:24 INFO - PROCESS | 1411 | 03:35:26 INFO - PROCESS | 1411 | Cycle 1(1): loaded http://localhost:50200/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50200/tests/kraken/driver.html?testName=audio-beat-detection) 03:35:27 INFO - PROCESS | 1411 | RSS: Main: 190922752 03:35:27 INFO - PROCESS | 1411 | 03:35:29 INFO - PROCESS | 1411 | Cycle 1(1): loaded http://localhost:50200/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50200/tests/kraken/driver.html?testName=audio-dft) 03:35:30 INFO - PROCESS | 1411 | RSS: Main: 185151488 03:35:30 INFO - PROCESS | 1411 | 03:35:33 INFO - PROCESS | 1411 | Cycle 1(1): loaded http://localhost:50200/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50200/tests/kraken/driver.html?testName=audio-fft) 03:35:33 INFO - PROCESS | 1411 | RSS: Main: 273620992 03:35:33 INFO - PROCESS | 1411 | 03:35:36 INFO - PROCESS | 1411 | Cycle 1(1): loaded http://localhost:50200/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50200/tests/kraken/driver.html?testName=audio-oscillator) 03:35:36 INFO - PROCESS | 1411 | RSS: Main: 183029760 03:35:36 INFO - PROCESS | 1411 | 03:35:38 INFO - PROCESS | 1411 | Cycle 1(1): loaded http://localhost:50200/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50200/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:35:39 INFO - PROCESS | 1411 | RSS: Main: 180584448 03:35:39 INFO - PROCESS | 1411 | 03:35:42 INFO - PROCESS | 1411 | Cycle 1(1): loaded http://localhost:50200/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50200/tests/kraken/driver.html?testName=imaging-darkroom) 03:35:42 INFO - PROCESS | 1411 | RSS: Main: 216330240 03:35:42 INFO - PROCESS | 1411 | 03:35:46 INFO - PROCESS | 1411 | Cycle 1(1): loaded http://localhost:50200/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50200/tests/kraken/driver.html?testName=imaging-desaturate) 03:35:46 INFO - PROCESS | 1411 | RSS: Main: 215576576 03:35:46 INFO - PROCESS | 1411 | 03:35:49 INFO - PROCESS | 1411 | Cycle 1(1): loaded http://localhost:50200/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50200/tests/kraken/driver.html?testName=json-parse-financial) 03:35:50 INFO - PROCESS | 1411 | RSS: Main: 215502848 03:35:50 INFO - PROCESS | 1411 | 03:35:51 INFO - PROCESS | 1411 | Cycle 1(1): loaded http://localhost:50200/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50200/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:35:52 INFO - PROCESS | 1411 | RSS: Main: 195072000 03:35:52 INFO - PROCESS | 1411 | 03:35:54 INFO - PROCESS | 1411 | Cycle 1(1): loaded http://localhost:50200/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50200/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:35:54 INFO - PROCESS | 1411 | RSS: Main: 197287936 03:35:54 INFO - PROCESS | 1411 | 03:35:56 INFO - PROCESS | 1411 | Cycle 1(1): loaded http://localhost:50200/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50200/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:35:57 INFO - PROCESS | 1411 | RSS: Main: 206966784 03:35:57 INFO - PROCESS | 1411 | 03:35:59 INFO - PROCESS | 1411 | Cycle 1(1): loaded http://localhost:50200/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:36:00 INFO - PROCESS | 1411 | RSS: Main: 215662592 03:36:00 INFO - PROCESS | 1411 | 03:36:03 INFO - PROCESS | 1411 | Cycle 1(1): loaded http://localhost:50200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:36:03 INFO - PROCESS | 1411 | RSS: Main: 210923520 03:36:03 INFO - PROCESS | 1411 | 03:36:05 INFO - PROCESS | 1411 | Cycle 1(1): loaded http://localhost:50200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50200/tests/kraken/driver.html?testName=ai-astar) 03:36:05 INFO - PROCESS | 1411 | RSS: Main: 275034112 03:36:05 INFO - PROCESS | 1411 | 03:36:05 INFO - PROCESS | 1411 | __start_tp_report 03:36:05 INFO - PROCESS | 1411 | _x_x_mozilla_page_load 03:36:05 INFO - PROCESS | 1411 | _x_x_mozilla_page_load_details 03:36:05 INFO - PROCESS | 1411 | |i|pagename|runs| 03:36:05 INFO - PROCESS | 1411 | |0;ai-astar;109;110;107;110;110;111;99;109;110;110 03:36:05 INFO - PROCESS | 1411 | |1;audio-beat-detection;153;125;152;176;129;159;152;128;174;133 03:36:05 INFO - PROCESS | 1411 | |2;audio-dft;160;161;161;163;161;160;161;164;162;162 03:36:05 INFO - PROCESS | 1411 | |3;audio-fft;72;74;76;183;76;73;77;77;162;77 03:36:05 INFO - PROCESS | 1411 | |4;audio-oscillator;92;91;148;91;92;92;142;91;93;143 03:36:05 INFO - PROCESS | 1411 | |5;imaging-gaussian-blur;116;118;117;117;117;117;116;116;116;117 03:36:05 INFO - PROCESS | 1411 | |6;imaging-darkroom;145;145;146;146;145;146;145;145;145;145 03:36:05 INFO - PROCESS | 1411 | |7;imaging-desaturate;94;94;94;94;95;94;94;94;94;94 03:36:05 INFO - PROCESS | 1411 | |8;json-parse-financial;56;57;58;58;56;59;58;78;58;54 03:36:05 INFO - PROCESS | 1411 | |9;json-stringify-tinderbox;59;59;58;58;59;60;59;58;58;58 03:36:05 INFO - PROCESS | 1411 | |10;stanford-crypto-aes;74;75;73;74;74;75;74;75;75;75 03:36:05 INFO - PROCESS | 1411 | |11;stanford-crypto-ccm;127;120;118;125;119;118;120;119;152;125 03:36:05 INFO - PROCESS | 1411 | |12;stanford-crypto-pbkdf2;158;156;159;158;161;161;165;162;160;163 03:36:05 INFO - PROCESS | 1411 | |13;stanford-crypto-sha256-iterative;67;69;67;66;68;67;67;66;65;67 03:36:05 INFO - PROCESS | 1411 | __end_tp_report 03:36:05 INFO - PROCESS | 1411 | __start_cc_report 03:36:05 INFO - PROCESS | 1411 | _x_x_mozilla_cycle_collect,1631 03:36:05 INFO - PROCESS | 1411 | __end_cc_report 03:36:05 INFO - PROCESS | 1411 | __startTimestamp1462530965601__endTimestamp 03:36:05 INFO - PROCESS | 1411 | 03:36:05 INFO - PROCESS | 1411 | ------- Summary: start ------- 03:36:05 INFO - PROCESS | 1411 | Number of tests: 14 03:36:05 INFO - PROCESS | 1411 | 03:36:05 INFO - PROCESS | 1411 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:3.50 (3.2%) stddev-sans-first:3.71 03:36:05 INFO - PROCESS | 1411 | Values: 109.0 110.0 107.0 110.0 110.0 111.0 99.0 109.0 110.0 110.0 03:36:05 INFO - PROCESS | 1411 | 03:36:05 INFO - PROCESS | 1411 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:152.50 stddev:18.72 (12.3%) stddev-sans-first:19.77 03:36:05 INFO - PROCESS | 1411 | Values: 153.0 125.0 152.0 176.0 129.0 159.0 152.0 128.0 174.0 133.0 03:36:05 INFO - PROCESS | 1411 | 03:36:05 INFO - PROCESS | 1411 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.27 (0.8%) stddev-sans-first:1.22 03:36:05 INFO - PROCESS | 1411 | Values: 160.0 161.0 161.0 163.0 161.0 160.0 161.0 164.0 162.0 162.0 03:36:05 INFO - PROCESS | 1411 | 03:36:05 INFO - PROCESS | 1411 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:41.34 (54.4%) stddev-sans-first:43.02 03:36:05 INFO - PROCESS | 1411 | Values: 72.0 74.0 76.0 183.0 76.0 73.0 77.0 77.0 162.0 77.0 03:36:05 INFO - PROCESS | 1411 | 03:36:05 INFO - PROCESS | 1411 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:91.50 stddev:25.47 (27.8%) stddev-sans-first:26.39 03:36:05 INFO - PROCESS | 1411 | Values: 92.0 91.0 148.0 91.0 92.0 92.0 142.0 91.0 93.0 143.0 03:36:05 INFO - PROCESS | 1411 | 03:36:05 INFO - PROCESS | 1411 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 03:36:05 INFO - PROCESS | 1411 | Values: 116.0 118.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 03:36:05 INFO - PROCESS | 1411 | 03:36:05 INFO - PROCESS | 1411 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 03:36:05 INFO - PROCESS | 1411 | Values: 145.0 145.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 03:36:05 INFO - PROCESS | 1411 | 03:36:05 INFO - PROCESS | 1411 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:36:05 INFO - PROCESS | 1411 | Values: 94.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 03:36:05 INFO - PROCESS | 1411 | 03:36:05 INFO - PROCESS | 1411 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:58.00 stddev:6.76 (11.7%) stddev-sans-first:7.07 03:36:05 INFO - PROCESS | 1411 | Values: 56.0 57.0 58.0 58.0 56.0 59.0 58.0 78.0 58.0 54.0 03:36:05 INFO - PROCESS | 1411 | 03:36:05 INFO - PROCESS | 1411 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 03:36:05 INFO - PROCESS | 1411 | Values: 59.0 59.0 58.0 58.0 59.0 60.0 59.0 58.0 58.0 58.0 03:36:05 INFO - PROCESS | 1411 | 03:36:05 INFO - PROCESS | 1411 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:75.00 stddev:0.70 (0.9%) stddev-sans-first:0.73 03:36:05 INFO - PROCESS | 1411 | Values: 74.0 75.0 73.0 74.0 74.0 75.0 74.0 75.0 75.0 75.0 03:36:05 INFO - PROCESS | 1411 | 03:36:05 INFO - PROCESS | 1411 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:122.50 stddev:10.26 (8.4%) stddev-sans-first:10.84 03:36:05 INFO - PROCESS | 1411 | Values: 127.0 120.0 118.0 125.0 119.0 118.0 120.0 119.0 152.0 125.0 03:36:05 INFO - PROCESS | 1411 | 03:36:05 INFO - PROCESS | 1411 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:161.00 stddev:2.67 (1.7%) stddev-sans-first:2.70 03:36:05 INFO - PROCESS | 1411 | Values: 158.0 156.0 159.0 158.0 161.0 161.0 165.0 162.0 160.0 163.0 03:36:05 INFO - PROCESS | 1411 | 03:36:05 INFO - PROCESS | 1411 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 03:36:05 INFO - PROCESS | 1411 | Values: 67.0 69.0 67.0 66.0 68.0 67.0 67.0 66.0 65.0 67.0 03:36:05 INFO - PROCESS | 1411 | -------- Summary: end -------- 03:36:05 INFO - PROCESS | 1411 | 03:36:06 INFO - TEST-INFO | 1411: exit 0 03:36:06 INFO - TEST-OK | kraken | took 60407ms 03:36:06 INFO - SUITE-END | took 1171s 03:36:06 INFO - Completed test suite (00:19:32) 03:36:06 INFO - javascript benchmark 03:36:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3308.652591477895, 3347.39746845568, 3364.0748794081624, 3367.9326413471745, 3401.523786669866, 5518.337799464065, 5526.50261476467, 5526.861828454291, 5528.198411230369, 5546.334439867216, 5527.143292789614, 5548.44515548445, 5550.69471179086, 5550.8057217997375, 5552.5280351170095, 4884.0, 5014.072396606631, 5030.6730062546, 5094.261332106842, 5101.872453188681, 4937.333459982892, 5019.623528235379, 5021.096202683516, 5025.924611130836, 5026.84919452417, 5026.547610715035, 5065.290859279704, 5128.692278463304, 5139.177731562932, 5171.301874246985, 5090.33825602673, 5120.769565369567, 5128.666636668605, 5130.0, 5159.58723302135, 4854.757262136879, 4936.654434189608, 5030.044291584587, 5037.471065538102, 5046.7476626168545, 5365.195220716884, 5402.486763757437, 5408.215808707715, 5408.945910540883, 5435.211894275308, 5787.450192231773, 5811.982902992002, 5812.302523697141, 5814.97092514539, 5818.185454036438, 5845.503132233765, 5848.122781582754, 5923.496502797268, 5955.910661340084, 5977.0, 5552.361478429952, 5563.944360556424, 5586.608937374426, 5595.38450770415, 5604.215409842666, 5928.79249226275, 6060.212172417646, 6069.393060693984, 6079.756809727562, 6080.179175811298, 5765.798197063083, 5834.241548598655, 5844.12338149281, 5845.824625261249, 5847.356790753014, 5866.560007999417, 5881.117832325185, 5881.941180588225, 5881.9705901470215, 5891.617044892154, 5758.193852860602, 5842.298924129047, 5843.3864444233595, 5849.64902105875, 5867.090600956859, 5882.3529411764675, 5886.793962211388, 5896.086106653475, 5896.351401345849, 5920.0, 4491.708038977456, 4494.101179763995, 4494.280915053576, 4499.572540608637, 4522.706024108423, 3968.523777146703, 4024.69814763888, 4036.1927614476635, 4073.327900896378, 4079.1025974286204, 5614.466625670555, 5639.43605639441, 5641.52047075995, 5643.125315576092, 5662.207290979266, 5930.140129681172, 5938.643681379045, 5946.10808378738, 5947.6431414115295, 5950.464458198783, 5455.290812194389, 5520.1167813149705, 5612.102063669875, 5627.43725627434, 5649.0396632572565, 5036.571891389273, 5074.517920797518, 5076.7207803571155, 5078.492150784892, 5079.111155547765, 6105.511559075263, 6105.8168254952425, 6106.053561697944, 6108.877822443526, 6109.877802443926, 5756.856078598153, 5904.232449781501, 5973.761049557969, 5992.280926288873, 6015.218021657157, 6008.459238668541, 6053.636781793107, 6059.6364218147055, 6062.757489700362, 6065.6663883486835, 5636.098224284095, 5726.112452569859, 5733.885322293614, 5740.282464691913, 5743.655380677173, 5840.1531777892815, 5859.882802344015, 5880.911786323294, 5882.205902203319, 5902.144189092472, 5787.710614469344, 5794.478496935296, 5797.188393624981, 5827.79602713903, 5836.066229403275, 5630.0991841305195, 5760.884782304247, 5794.420557944172, 5806.82579522615, 5811.070228763378, 5646.548276137982, 5668.574856885668, 5673.035583950656, 5673.290838645169, 5708.80019199326, 5752.28096487939, 5773.74018169175, 5776.364599893925, 5776.942230577641, 5783.508401785727, 5561.888762224814, 5653.491185793298, 5676.432356764456, 5692.943070569241, 5774.884502310014], "value": 5446.476415774172, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.1246941567715, 667.2393471442559, 670.3899451499137, 685.3557655803544, 749.3892477630731, 32211.35577288453, 40043.599564004355, 41009.38485922714, 41144.0, 41206.58793412065, 43258.0, 43911.78044109783, 43936.780316098375, 43944.56055439445, 43968.78015609925, 8675.60959756811, 8895.599698013604, 8896.599653015597, 8900.910990890105, 8906.42108262964, 8363.247307742302, 8461.703840365588, 8485.61814718336, 8488.108748581371, 8655.17775811297, 8724.0, 8746.125387461234, 8747.825043499159, 8748.475091494498, 8756.60595273211, 8682.956585217065, 8706.347023973227, 8708.738737837875, 8710.651573937066, 8710.69512567057, 8723.694670686495, 8826.602802873886, 8827.911720882774, 8829.16122968317, 9060.139286767746, 43825.34261986073, 44271.335929961075, 44277.55722442766, 44366.33450498245, 44436.77781611071, 3933.9016524586827, 3964.7621142731527, 4049.5950404959563, 4141.964508872782, 4331.7834108294455, 34192.82903585466, 34353.31293374119, 34475.0, 34772.30455390903, 36313.27373452543, 4469.374287599739, 4473.888152796174, 4475.77621118946, 4523.2988886722615, 4584.977075114603, 325241.0, 325617.0, 327152.0, 327570.0, 330172.7930882762, 38723.2255354897, 38994.0, 61048.38951610516, 61235.0, 61635.38364616296, 40164.19671606552, 40290.395644065364, 40295.19409611791, 40316.59683403187, 40325.0, 17100.657986840193, 17333.91333043352, 17354.566135846704, 17355.739663905053, 17366.0, 14499.420023199165, 14567.854321456862, 14605.123692578267, 14607.19660418687, 14617.415303387957, 9510.762230944143, 9547.236221102296, 9560.187384072431, 9575.760605984768, 9648.71053868385, 3658.579263384692, 3677.8528858845348, 3679.466477360821, 3683.4106542953, 3734.327820992193, 1107.5514416661103, 1146.7993101207421, 1190.8928196462186, 1220.2251570252777, 1237.3998610673816, 34373.0, 34441.483377749355, 34633.826830866186, 34761.0, 34967.0, 1208.1482554798845, 1284.9743005139844, 1318.953836615714, 1322.6759443936105, 1331.7136815584695, 18176.56954578491, 18311.63376732458, 18399.90800046018, 18507.629847402975, 18603.255869765057, 554553.0, 564718.0, 568970.0, 572171.0, 574668.0, 62606.0, 62707.6864615674, 63159.0, 63254.0, 63379.36620633735, 1495.6634757179547, 1508.057464084947, 1530.3878448620642, 1533.9693206136037, 1559.7894284271706, 30163.095107145942, 32515.18712032218, 33559.66440335663, 33600.15999599932, 34057.65942340545, 48863.0, 49525.75237123791, 49532.0, 49539.752301238266, 49564.0, 315327.0, 317285.0, 320745.0, 321788.0, 322072.0, 25567.105151319614, 30595.54106688357, 44758.77620611876, 44842.0, 46127.53872461232, 48850.75574622104, 49523.50476495189, 49832.25251621156, 50074.248886267465, 50312.245316321016, 42323.57676423196, 42587.0, 42658.78670606627, 42819.785901070296, 43945.12109757723, 44114.95897160816, 44623.77688111539, 44720.10559788721, 46035.76982115202, 46710.76644616755, 46724.0, 47755.0, 47806.0, 48526.5147348522, 48989.510104898494, 40180.598194017686, 40823.38764918588, 41132.383014254214, 41159.1768164629, 41646.58353416427, 31061.8446907764, 31488.685113148575, 31513.52729709102, 31517.684823151474, 32274.677253228107], "value": 19973.815576484565, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.63369551642324, 421.20602663978394, 427.7027465911193, 429.7056516286342, 432.35578987308907, 18427.631447371044, 18523.981181035055, 19013.144408501616, 19128.808711912876, 19194.328198513056, 18586.907065464653, 18712.532186695305, 19716.112774925128, 19740.111694973726, 19762.703559446585, 5428.104362780146, 5769.682667453289, 5786.045302525078, 5790.68151251681, 5794.62334948227, 5524.696141712204, 5701.287339082614, 5738.856528586777, 5745.683987380692, 5748.367679555246, 5735.4551317624755, 5759.308882934054, 5763.135529670562, 5768.769249230026, 5770.653760774367, 5515.4760297771645, 5732.5987180897355, 5733.254676892019, 5736.225609542721, 5738.139279108125, 5121.078205922932, 5137.537621614073, 5143.434222235551, 5155.587552995751, 5161.587073034186, 18098.819011809977, 21782.89108554463, 21815.45461363463, 22387.0, 22419.775802242097, 2311.526137141882, 2427.4659574893494, 2483.615039668854, 2541.542522345977, 2579.0, 9797.461139637317, 9974.351667141686, 10017.799644007151, 10062.195024398105, 13472.5284615038, 1994.3917105282883, 2033.2070492507933, 2038.6534289170877, 2095.863768855035, 2132.040581738224, 82183.58908205481, 90482.09517904803, 90778.09221907762, 91361.54319228428, 92323.0, 10813.513391897384, 11065.446727663584, 11147.665570032912, 11296.6046188383, 11335.263207891461, 16068.634166095779, 16134.0, 16173.838261617468, 16222.594435139215, 16227.107509087113, 7925.207479252029, 8058.874890856929, 8060.596970151469, 8246.257836794717, 8252.257296843192, 7790.220977902164, 7836.098848632366, 7869.173736757558, 7910.090339611018, 7925.722599708983, 4877.707337559757, 4906.533879281463, 4917.950820491821, 4928.383952005999, 5118.413291879529, 2003.3188715836686, 2010.3164923925935, 2051.8153366197116, 2069.317125348631, 2095.4656562576447, 986.1666891476691, 1066.1204506282193, 1147.8794726553592, 1159.4666453431516, 1171.5606647507184, 18285.63428731418, 18691.252349906124, 18989.0, 19177.0, 19471.0, 1062.5802807890839, 1074.8065348237392, 1086.6957251969461, 1151.6026970695098, 1161.9128565357462, 10335.276530642783, 10660.520276587573, 10723.19576031785, 10826.458677066115, 10865.51105200268, 499315.0, 500966.0, 504407.0, 507738.0, 509564.0, 102705.48647256717, 107609.0, 107876.0, 109506.45246773715, 109654.0, 1101.983470247947, 1125.0, 1135.1543100390097, 1148.7013376522164, 1158.5481662151767, 16952.915235423745, 17015.65968680644, 17134.571635709206, 17282.827171728626, 17603.29586816513, 37674.62325376821, 38920.22159556737, 42482.36276455918, 43726.78136609297, 44434.55565444433, 56663.433365667464, 59723.0, 59906.40093599183, 60515.092273616814, 61025.0, 8260.917390826015, 8414.368922330972, 8633.525156116473, 8644.956775216335, 9021.097890210927, 9232.076792320715, 12785.61643150707, 12888.162269452456, 13140.0801943863, 13643.86356136426, 11763.882361176278, 11790.528378864748, 11949.22330048544, 12041.09691773103, 12152.270863748203, 11793.823092653789, 12232.755344892874, 12295.139340246096, 12406.379681016093, 12712.809307860205, 11975.520979160736, 12165.513379464723, 12675.873241267469, 12703.237805731686, 12728.751525010137, 8277.84110224557, 8412.915870841212, 8795.25240354577, 8839.425437346552, 9248.21390181842, 8463.984321881413, 11387.772244555228, 11848.70378240551, 11904.0, 12158.209716368408], "value": 9438.334229643035, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.8466768655453, 1568.4588816858184, 1584.8811339149563, 1782.572182676158, 1872.7284543741157, 8128.878066828995, 8438.2827459666, 8439.113893041234, 8451.492910425379, 8457.957710211447, 8158.877616835753, 8350.624221910013, 8359.582020898946, 8364.2472177504, 8382.455140415868, 2104.0531760707745, 2311.087120587367, 2352.8117750579954, 2367.550165468564, 2381.92854214373, 2358.9528209435803, 2368.7394386617457, 2369.3484291819714, 2369.763023697634, 2372.4306166519996, 2289.8511596746243, 2335.369450248432, 2337.1936681844822, 2338.684277622516, 2339.2748248043076, 2080.7411516032807, 2293.816494680422, 2346.530693861235, 2361.232599405183, 2361.4450604108106, 2249.156566287642, 2249.8200143988443, 2251.79733823955, 2271.8750468724215, 2327.104064935012, 8564.272036876873, 8576.44253123545, 8657.26413254874, 8670.349723770742, 8685.565721713889, 5109.846704598868, 5315.468453154692, 5341.946580534183, 5356.54469370104, 5361.919571206435, 3275.3449310138067, 3285.162283617686, 3339.34882697874, 3415.504751810998, 3417.709494692929, 1068.9893101069044, 1073.3988966178965, 1095.5508241620978, 1112.1214240749798, 1130.604288499027, 11748.882511174865, 11756.94121529387, 11805.0, 11828.585999490062, 11835.0, 4486.753228572395, 4556.3621093047, 4580.839670611579, 4585.518520555361, 4649.395578574764, 10149.847752283722, 10169.745756356151, 10174.186065114773, 10202.33684810485, 10203.183745300357, 4696.272077827942, 5297.443768404339, 5420.214068959979, 5426.620136590401, 5427.1316589345515, 4735.668503204812, 4831.661783675179, 4863.1003264395495, 4869.537393947569, 4873.585745211626, 4003.53959294679, 4007.5800457756127, 4099.487564054493, 4107.486564179478, 4127.33962565988, 1250.7998720204905, 1285.9357032148541, 1294.5210272199347, 1295.352323838081, 1313.8292022037074, 998.0717932323009, 1015.9339642923186, 1023.4780262066251, 1025.3079171559168, 1028.8148133336072, 5729.226554415184, 5769.1923130761725, 5809.186713860063, 5881.441263080001, 5915.349311575723, 445.08757048051365, 448.28498544820957, 448.77561219390304, 1088.7495875948575, 1124.5839039555253, 4048.4939382577177, 4058.4521089652517, 4058.6753059755147, 4060.918781624351, 4085.571015043437, 10358.741031474123, 10745.14038876888, 10839.295445795999, 10878.020978112008, 10905.18211134168, 10557.155427565776, 10679.466026698634, 10749.731256718645, 10752.0, 10800.0, 8274.255317021498, 8383.371247156487, 8432.0, 8434.957825210835, 8458.619362128842, 5680.71596420169, 5768.53851691872, 5885.47030767233, 5887.0, 5890.352061273171, 9808.607655693691, 9810.705678829647, 10064.849027264743, 10074.8488772667, 10231.079202871777, 9905.455199963782, 10147.238957078102, 10191.388516689023, 10237.48812559384, 10409.219308552041, 7029.507934444539, 7547.358474529727, 7751.604711152047, 7821.804454888445, 7997.680092796223, 8426.241638252586, 8430.83138337242, 8468.44955077918, 8500.787480313042, 8509.74470765878, 7481.588512631857, 7643.656035478528, 7668.961655191688, 7735.883961740691, 7782.2217778223985, 7563.848723025619, 7606.125295591078, 7665.23347665229, 7691.538507689556, 7758.224177582197, 7029.156501219886, 7235.2764723529335, 7275.490715650066, 7281.817954551178, 7285.380742636723, 4795.9280610790165, 4835.758212089311, 4932.21084626458, 5024.321716568363, 5033.924491132562, 4915.090708218991, 5189.506996835295, 5303.7082960436, 5364.195370694427, 5390.0], "value": 4584.739113431171, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.4488280158127, 322.40516247523317, 322.72890771751725, 338.9271306669064, 339.7689571091657, 5318.521333080022, 5351.4380989996025, 5374.838754837357, 5417.674939503623, 5449.863753406157, 5338.893222135555, 5363.141897296433, 5373.865653358658, 5385.21914322423, 5393.1910213468, 4021.4168945502884, 4081.6530594899323, 4185.623293903548, 4219.2616292148905, 4242.172776308621, 4170.186813571355, 4174.519930208035, 4201.327787553992, 4215.913123004118, 4231.746095234295, 3993.361062230044, 4175.0, 4177.749335039907, 4187.811548480326, 4188.539260681323, 4070.409790580364, 4170.6871984600975, 4175.331946888483, 4186.518550366716, 4217.894552636178, 3659.8536058557625, 3687.9815600922093, 3704.703084087856, 3707.7404581679293, 3711.164987877733, 5153.871153221162, 5155.664881782672, 5178.197379406198, 5178.585713142939, 5194.35070616173, 4433.224185767478, 4687.812487500496, 4700.412448443944, 4711.552402521755, 4756.904861902743, 5519.337679478448, 5548.361938377098, 5572.944270557283, 5585.720713964326, 5607.4112218217315, 3919.392494163409, 3941.4284928685465, 3952.5849785772657, 3955.762654240726, 3968.4840970673918, 5582.302212223472, 5820.30156381237, 5855.2187710837015, 5856.297244330665, 5856.355800861902, 4032.6773858091283, 4061.1674606705556, 4066.8576599819457, 4071.1043570414463, 4098.73358231714, 4088.6524645405475, 4099.61053699898, 4125.752454852718, 4131.47979732363, 4133.318002529549, 4610.723356598614, 4735.147673418749, 4752.976235118871, 4755.809767609257, 4768.666193366431, 5639.492445679908, 5661.7735290588735, 5667.4615911488345, 5678.14827775837, 5684.744186511534, 1495.723291191133, 1507.4045751927927, 1507.4422463688286, 1510.9773353399708, 1512.599161222277, 907.804821963281, 938.8028514011997, 997.6308765756717, 999.5701848205341, 1005.1506477026901, 5752.02215623345, 5782.739776710058, 5793.449622285876, 5801.94198058014, 5814.098814683731, 6094.847628809315, 6096.481799047042, 6121.96939015311, 6122.602030867979, 6131.724072416752, 5298.655587386807, 5581.325602319288, 5595.552355811526, 5615.466530679579, 5779.682117483495, 3302.867885284562, 3303.306305675787, 3303.5540202072893, 3313.122022663996, 3318.5354050432957, 6256.217972753406, 6361.173047503795, 6402.8719425611225, 6459.224893012774, 6459.838504037437, 6213.887278325301, 6275.529335299871, 6277.2153480814895, 6302.212223472066, 6335.11308416822, 6265.718042688181, 6425.389587989227, 6431.710573024225, 6440.54916155874, 6473.255575608865, 6183.258009038944, 6191.597546159485, 6196.752129914753, 6211.844703882439, 6242.812715618538, 6144.662043587646, 6163.167972323679, 6169.2288463942, 6183.268684768272, 6185.8144255672405, 5824.242848429846, 5925.40745925404, 6093.421124993119, 6099.9390006099375, 6454.419102280817, 4004.939925901172, 4035.596440355941, 4060.1879624074713, 4087.9182416350914, 4099.200655872076, 5743.195952566561, 5831.650100993954, 5884.32330282023, 5889.99740088372, 5901.409859014064, 5742.425757424224, 5761.884762304814, 5764.971175144097, 5766.3368712598585, 5777.064683331131, 5682.119271512922, 5698.202251684685, 5707.429257074259, 5707.714614269353, 5758.596898217084, 5435.673859568438, 5632.324121105494, 5633.915491267552, 5645.350784659817, 5646.209530665628, 5713.600167958876, 5756.884862302814, 5764.250647415809, 5765.682887441231, 5777.6822274775295, 5599.188117722826, 5609.635373700697, 5619.325680918316, 5633.943660563506, 5647.774089036392], "value": 4373.616483058546, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [860.2816648098838, 860.6772460327377, 866.7746385939656, 884.8805411269481, 915.6840889892984, 14387.928060359696, 14760.852391476083, 14791.260436978162, 14797.926010369933, 14808.925955370209, 14623.0, 14650.19423931686, 14692.191929443876, 14789.40842366304, 14796.55610331689, 765.9502132361406, 888.3470649072926, 896.3680605173354, 926.3237836379448, 931.3713243560603, 930.6742640075987, 933.5565606337003, 933.7105497295826, 934.850423932171, 935.9532023398837, 792.1603100713234, 952.1906379577373, 976.038601977052, 978.921686265097, 979.304693667497, 973.6738192705452, 975.4439969217584, 976.067855198284, 976.2726768557435, 978.2516374973151, 719.5358993449196, 720.0423436829058, 721.12383454103, 721.6139365439517, 721.9675114619802, 15201.163935983517, 15242.618934526614, 15289.61775955599, 15318.693626127415, 15344.693106137925, 14765.852341476555, 15198.392064317413, 15456.227188640523, 15462.0, 15490.61273468161, 11634.243774154738, 11808.350540720257, 11848.822267665906, 12000.159988800788, 12120.939395302967, 3948.7828169450668, 3953.367461206193, 3990.182012687392, 4005.0588111793704, 4110.095778928631, 52325.7383713079, 52386.47613523854, 52441.0, 52962.73518632421, 53037.0, 10323.225758068174, 10433.530491127918, 10670.0, 10672.25294229412, 10842.457877106272, 19192.520186995436, 19449.8055019448, 19516.31692890742, 19537.804621953597, 19607.509812254524, 8111.351091912633, 8199.918000819915, 8606.44058136219, 8608.95695521531, 8882.467051976902, 4804.591609713214, 4985.476524964826, 5007.924881126786, 5121.103806833789, 5125.666831655931, 3441.8795342162903, 3502.5446691930397, 3505.0361150683257, 3511.719062475047, 3513.1392808762016, 702.259116631948, 723.4248772226093, 725.9165196002422, 726.3208899678817, 726.7202127181073, 763.7059732003107, 780.3990926986189, 793.2107552984817, 820.6635279535362, 829.9045609754955, 10023.0, 10054.447005414626, 10088.949555252177, 10108.949455252823, 10129.139023182965, 693.8300116471497, 749.7863109014014, 767.8234006178499, 771.9189485104096, 791.7743443118799, 4606.332081848113, 4652.744099074515, 4690.530946905282, 4769.332293478916, 4797.328374027639, 62022.0, 62231.6888415555, 63523.68238158872, 66321.0, 66483.0, 53968.190477142874, 55375.72312138414, 56273.43726562764, 56779.0, 58536.12195817066, 52588.73705631447, 52651.47348526542, 53237.0, 53504.46495534995, 53784.19323710148, 9175.403598766059, 9219.446833189762, 9360.485173315534, 9419.340646154704, 9511.76220594463, 30895.84552077225, 32663.18342041468, 33168.0, 35355.64644353523, 36009.21903200231, 44585.77707111444, 44819.77590112029, 46079.76960115178, 46418.53581464142, 46516.30225546687, 12068.698282543006, 12080.39598020078, 12343.135980481638, 12596.622101336974, 12632.873671263538, 13702.93148534251, 13870.167789932233, 14249.002569820428, 14603.196824174773, 14668.413263469341, 14167.220802855942, 14188.148711077369, 14218.857811421753, 14294.0, 14331.713365732418, 13437.462501499831, 13689.041767076607, 13691.589252322447, 13729.588112356645, 13901.0964287321, 12937.353132343156, 13087.214767114003, 13106.803397949228, 13192.142510736772, 13461.057725959088, 11274.879504532497, 11529.1929564933, 11668.94165529167, 11863.34751588671, 11887.76224475523, 11367.317960922372, 11433.1996760226, 11487.597934072268, 11555.364454955059, 11644.35956022393], "value": 7170.830364173726, "unit": "score"}], "name": "dromaeo_css", "value": 7270.09478974487, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 107.0, 110.0, 110.0, 111.0, 99.0, 109.0, 110.0, 110.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 152.0, 176.0, 129.0, 159.0, 152.0, 128.0, 174.0, 133.0], "value": 148.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 163.0, 161.0, 160.0, 161.0, 164.0, 162.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 76.0, 183.0, 76.0, 73.0, 77.0, 77.0, 162.0, 77.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 148.0, 91.0, 92.0, 92.0, 142.0, 91.0, 93.0, 143.0], "value": 107.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 58.0, 56.0, 59.0, 58.0, 78.0, 58.0, 54.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 58.0, 59.0, 60.0, 59.0, 58.0, 58.0, 58.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 74.0, 74.0, 75.0, 74.0, 75.0, 75.0, 75.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 120.0, 118.0, 125.0, 119.0, 118.0, 120.0, 119.0, 152.0, 125.0], "value": 124.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 159.0, 158.0, 161.0, 161.0, 165.0, 162.0, 160.0, 163.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 66.0, 68.0, 67.0, 67.0, 66.0, 65.0, 67.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1520.1000000000001, "alertThreshold": 2.0}]} 03:36:06 INFO - Return code: 0 03:36:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:36:06 ERROR - # TBPL SUCCESS # 03:36:06 INFO - Running post-action listener: _resource_record_post_action 03:36:06 INFO - Running post-run listener: _resource_record_post_run 03:36:07 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 497717248; Read time: 12; Write time: 679112 03:36:07 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 248733696; Read time: 0; Write time: 453636 03:36:07 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 248930304; Read time: 12; Write time: 225456 03:36:07 INFO - Running post-run listener: _upload_blobber_files 03:36:07 INFO - Blob upload gear active. 03:36:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:36:07 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 03:36:07 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:36:07 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:36:08 INFO - (blobuploader) - INFO - Open directory for files ... 03:36:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:36:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:36:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:09 INFO - (blobuploader) - INFO - Done attempting. 03:36:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:36:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:36:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:09 INFO - (blobuploader) - INFO - Done attempting. 03:36:09 INFO - (blobuploader) - INFO - Iteration through files over. 03:36:09 INFO - Return code: 0 03:36:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:36:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:36:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa8da97ba65e8b5b3f5fad913f249d97d40cb229fff7e6ad1b97744456fbe9505685e79751cb1d30011fb19c09edfd4cad04bd53411e63524685e16545a496bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/702c1898b8bbbd460b2df1b9b1c36e3d13a15cf83c5701c2001b0773e98f4cf64f7050534cfbf2f6a3de53cdffa46fe0e4c08e543db0a8790545e375efe2053b"} 03:36:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:36:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:36:09 INFO - Contents: 03:36:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa8da97ba65e8b5b3f5fad913f249d97d40cb229fff7e6ad1b97744456fbe9505685e79751cb1d30011fb19c09edfd4cad04bd53411e63524685e16545a496bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/702c1898b8bbbd460b2df1b9b1c36e3d13a15cf83c5701c2001b0773e98f4cf64f7050534cfbf2f6a3de53cdffa46fe0e4c08e543db0a8790545e375efe2053b"} 03:36:09 INFO - Running post-run listener: copy_logs_to_upload_dir 03:36:09 INFO - Copying logs to upload dir... 03:36:09 INFO - mkdir: /builds/slave/test/build/upload/logs 03:36:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.233408 ========= master_lag: 0.83 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-06 03:36:10.043887) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 03:36:10.048161) ========= 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=aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770 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-Aurora/sha512/fa8da97ba65e8b5b3f5fad913f249d97d40cb229fff7e6ad1b97744456fbe9505685e79751cb1d30011fb19c09edfd4cad04bd53411e63524685e16545a496bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/702c1898b8bbbd460b2df1b9b1c36e3d13a15cf83c5701c2001b0773e98f4cf64f7050534cfbf2f6a3de53cdffa46fe0e4c08e543db0a8790545e375efe2053b"} build_url:https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa8da97ba65e8b5b3f5fad913f249d97d40cb229fff7e6ad1b97744456fbe9505685e79751cb1d30011fb19c09edfd4cad04bd53411e63524685e16545a496bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/702c1898b8bbbd460b2df1b9b1c36e3d13a15cf83c5701c2001b0773e98f4cf64f7050534cfbf2f6a3de53cdffa46fe0e4c08e543db0a8790545e375efe2053b"}' ========= master_lag: 0.70 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 03:36:10.756142) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:36:10.756558) ========= 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=aa52b8aba932b19cc50b5275000001de-1462524611.972907-699841770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:36:10.778650) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 03:36:10.779097) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 03:36:10.867392) ========= ========= Total master_lag: 1.61 =========