builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1462529727.14 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.144151) ========= 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.144604) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.144893) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.201601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.201861) ========= 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=fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349 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% 96.0M=0s 2016-05-06 03:15:27 (96.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116375 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.333974) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.334265) ========= 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=fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020197 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:27.384687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 03:15:27.384995) ========= 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=fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 03:15:27,942 truncating revision to first 12 chars 2016-05-06 03:15:27,942 Setting DEBUG logging. 2016-05-06 03:15:27,942 attempt 1/10 2016-05-06 03:15:27,942 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:29,238 unpacking tar archive at: mozilla-aurora-0123e9f41ced/testing/mozharness/ program finished with exit code 0 elapsedTime=1.581315 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 03:15:28.980765) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:28.981038) ========= script_repo_revision: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:28.981411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:28.981671) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:28.992928) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-06 03:15:28.993317) ========= /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=fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:15:29 INFO - MultiFileLogger online at 20160506 03:15:29 in /builds/slave/test 03:15:29 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:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:15:29 INFO - {'append_to_log': False, 03:15:29 INFO - 'base_work_dir': '/builds/slave/test', 03:15:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:15:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:15:29 INFO - 'branch': 'Mozilla-Aurora', 03:15:29 INFO - 'buildbot_json_path': 'buildprops.json', 03:15:29 INFO - 'config_files': ('talos/linux_config.py',), 03:15:29 INFO - 'default_actions': ('clobber', 03:15:29 INFO - 'read-buildbot-config', 03:15:29 INFO - 'download-and-extract', 03:15:29 INFO - 'populate-webroot', 03:15:29 INFO - 'create-virtualenv', 03:15:29 INFO - 'install', 03:15:29 INFO - 'run-tests'), 03:15:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:15:29 INFO - 'download_minidump_stackwalk': True, 03:15:29 INFO - 'download_symbols': 'ondemand', 03:15:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:15:29 INFO - 'tooltool.py': '/tools/tooltool.py', 03:15:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:15:29 INFO - '/tools/misc-python/virtualenv.py')}, 03:15:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:15:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:15:29 INFO - 'installer_path': 'installer.exe', 03:15:29 INFO - 'log_level': 'info', 03:15:29 INFO - 'log_name': 'talos', 03:15:29 INFO - 'log_to_console': True, 03:15:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:15:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:15:29 INFO - 'opt_config_files': (), 03:15:29 INFO - 'pip_index': False, 03:15:29 INFO - 'sps_profile': False, 03:15:29 INFO - 'sps_profile_interval': 0, 03:15:29 INFO - 'suite': 'dromaeojs', 03:15:29 INFO - 'system_bits': '32', 03:15:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:15:29 INFO - 'title': 'talos-linux64-ix-048', 03:15:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:15:29 INFO - 'use_talos_json': True, 03:15:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:15:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:15:29 INFO - 'work_dir': 'build'} 03:15:29 INFO - ##### 03:15:29 INFO - ##### Running clobber 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: clobber 03:15:29 INFO - rmtree: /builds/slave/test/build 03:15:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:15:30 INFO - Running post-action listener: _resource_record_post_action 03:15:30 INFO - ##### 03:15:30 INFO - ##### Running read-buildbot-config step. 03:15:30 INFO - ##### 03:15:30 INFO - Running pre-action listener: _resource_record_pre_action 03:15:30 INFO - Running main action method: read_buildbot_config 03:15:30 INFO - Using buildbot properties: 03:15:30 INFO - { 03:15:30 INFO - "project": "", 03:15:30 INFO - "product": "firefox", 03:15:30 INFO - "script_repo_revision": "production", 03:15:30 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:15:30 INFO - "repository": "", 03:15:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:15:30 INFO - "buildid": "20160505123841", 03:15:30 INFO - "pgo_build": "True", 03:15:30 INFO - "basedir": "/builds/slave/test", 03:15:30 INFO - "buildnumber": 486, 03:15:30 INFO - "slavename": "talos-linux64-ix-048", 03:15:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:15:30 INFO - "platform": "ubuntu64_hw", 03:15:30 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:15:30 INFO - "branch": "mozilla-aurora", 03:15:30 INFO - "repo_path": "releases/mozilla-aurora", 03:15:30 INFO - "revision": "0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b", 03:15:30 INFO - "stage_platform": "linux64-pgo", 03:15:30 INFO - "builduid": "1457772db7ef4c1982b4796b67a4914d", 03:15:30 INFO - "slavebuilddir": "test" 03:15:30 INFO - } 03:15:30 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:30 INFO - Running post-action listener: _resource_record_post_action 03:15:30 INFO - ##### 03:15:30 INFO - ##### Running download-and-extract step. 03:15:30 INFO - ##### 03:15:30 INFO - Running pre-action listener: _resource_record_pre_action 03:15:30 INFO - Running main action method: download_and_extract 03:15:30 INFO - mkdir: /builds/slave/test/build/tests 03:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:30 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:30 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:30 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:30 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:30 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:36 INFO - Downloaded 1361 bytes. 03:15:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:15:36 INFO - Using the following test package requirements: 03:15:36 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:15:36 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:15:36 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:15:36 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:36 INFO - u'jsshell-linux-x86_64.zip'], 03:15:36 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:15:36 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:15:36 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:15:36 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:15:36 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:15:36 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:15:36 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:36 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:36 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:36 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:36 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:36 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:38 INFO - Downloaded 23824026 bytes. 03:15:38 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:38 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:39 INFO - Return code: 0 03:15:39 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:39 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:39 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:39 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:39 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:39 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:39 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:50 INFO - Downloaded 23824026 bytes. 03:15:50 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:50 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: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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:15:51 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:52 INFO - Downloaded 10840145 bytes. 03:15:52 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:52 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:52 INFO - Return code: 0 03:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:52 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:52 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:52 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:52 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:52 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:54 INFO - Downloaded 62687148 bytes. 03:15:54 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:54 INFO - mkdir: /builds/slave/test/properties 03:15:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:15:54 INFO - Writing to file /builds/slave/test/properties/build_url 03:15:54 INFO - Contents: 03:15:54 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:54 INFO - Running post-action listener: _resource_record_post_action 03:15:54 INFO - Running post-action listener: set_extra_try_arguments 03:15:54 INFO - ##### 03:15:54 INFO - ##### Running populate-webroot step. 03:15:54 INFO - ##### 03:15:54 INFO - Running pre-action listener: _resource_record_pre_action 03:15:54 INFO - Running main action method: populate_webroot 03:15:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:15:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:15:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:15:54 INFO - '--tppagecycles', 03:15:54 INFO - '7'], 03:15:54 INFO - 'tests': ['tsvgm']}}, 03:15:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:15:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:15:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:15:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:15:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:15:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:15:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:54 INFO - 'talos_options': ['--disable-e10s'], 03:15:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:54 INFO - 'talos_options': ['--disable-e10s'], 03:15:54 INFO - 'tests': ['damp', 'tps']}, 03:15:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:54 INFO - 'tests': ['damp', 'tps']}, 03:15:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:15:54 INFO - 'tests': ['dromaeo_dom']}, 03:15:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:15:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:15:54 INFO - 'tests': ['a11yr', 03:15:54 INFO - 'ts_paint', 03:15:54 INFO - 'tpaint', 03:15:54 INFO - 'sessionrestore', 03:15:54 INFO - 'sessionrestore_no_auto_restore', 03:15:54 INFO - 'tabpaint']}, 03:15:54 INFO - 'other-e10s': {'tests': ['a11yr', 03:15:54 INFO - 'ts_paint', 03:15:54 INFO - 'tpaint', 03:15:54 INFO - 'sessionrestore', 03:15:54 INFO - 'sessionrestore_no_auto_restore', 03:15:54 INFO - 'tabpaint']}, 03:15:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:15:54 INFO - 'ts_paint', 03:15:54 INFO - 'tpaint', 03:15:54 INFO - 'sessionrestore', 03:15:54 INFO - 'sessionrestore_no_auto_restore', 03:15:54 INFO - 'tabpaint']}, 03:15:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:15:54 INFO - 'ts_paint', 03:15:54 INFO - 'tpaint', 03:15:54 INFO - 'sessionrestore', 03:15:54 INFO - 'sessionrestore_no_auto_restore', 03:15:54 INFO - 'tabpaint']}, 03:15:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:15:54 INFO - 'tests': ['a11yr', 03:15:54 INFO - 'ts_paint', 03:15:54 INFO - 'tpaint', 03:15:54 INFO - 'sessionrestore', 03:15:54 INFO - 'sessionrestore_no_auto_restore', 03:15:54 INFO - 'tabpaint']}, 03:15:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:15:54 INFO - 'tests': ['a11yr', 03:15:54 INFO - 'ts_paint', 03:15:54 INFO - 'tpaint', 03:15:54 INFO - 'sessionrestore', 03:15:54 INFO - 'sessionrestore_no_auto_restore', 03:15:54 INFO - 'tabpaint']}, 03:15:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:15:54 INFO - 'tests': ['tsvgx', 03:15:54 INFO - 'tsvgr_opacity', 03:15:54 INFO - 'tart', 03:15:54 INFO - 'tscrollx', 03:15:54 INFO - 'cart']}, 03:15:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:15:54 INFO - 'tsvgr_opacity', 03:15:54 INFO - 'tart', 03:15:54 INFO - 'tscrollx', 03:15:54 INFO - 'cart']}, 03:15:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:54 INFO - 'talos_options': ['--disable-e10s'], 03:15:54 INFO - 'tests': ['tp5o']}, 03:15:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:54 INFO - 'tests': ['tp5o']}, 03:15:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:54 INFO - 'talos_options': ['--disable-e10s', 03:15:54 INFO - '--xperf_path', 03:15:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:54 INFO - 'tests': ['tp5n']}, 03:15:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:54 INFO - 'talos_options': ['--xperf_path', 03:15:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:54 INFO - 'tests': ['tp5n']}}, 03:15:54 INFO - 'talos.zip': {'path': '', 03:15:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:15:54 INFO - Running post-action listener: _resource_record_post_action 03:15:54 INFO - ##### 03:15:54 INFO - ##### Running create-virtualenv step. 03:15:54 INFO - ##### 03:15:54 INFO - Running pre-action listener: _resource_record_pre_action 03:15:54 INFO - Running main action method: create_virtualenv 03:15:54 INFO - Creating virtualenv /builds/slave/test/build/venv 03:15:54 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:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:15:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:15:55 INFO - Using real prefix '/usr' 03:15:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:15:55 INFO - Installing distribute.............................................................................................................................................................................................done. 03:15:57 INFO - Installing pip.................done. 03:15:57 INFO - Return code: 0 03:15:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:15:57 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:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:57 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:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:57 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 0x7ff4ce2fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d37410>, '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 0x1d38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d387a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', '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:57 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:57 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:57 INFO - Using env: {'DISPLAY': ':0', 03:15:57 INFO - 'HOME': '/home/cltbld', 03:15:57 INFO - 'LANG': 'en_US.UTF-8', 03:15:57 INFO - 'LANGUAGE': 'en_US:en', 03:15:57 INFO - 'LOGNAME': 'cltbld', 03:15:57 INFO - 'MAIL': '/var/mail/cltbld', 03:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:57 INFO - 'MOZ_NO_REMOTE': '1', 03:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:57 INFO - 'NO_EM_RESTART': '1', 03:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:57 INFO - 'PWD': '/builds/slave/test', 03:15:57 INFO - 'SHELL': '/bin/bash', 03:15:57 INFO - 'SHLVL': '1', 03:15:57 INFO - 'TERM': 'linux', 03:15:57 INFO - 'TMOUT': '86400', 03:15:57 INFO - 'USER': 'cltbld', 03:15:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', 03:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:57 INFO - '_': '/tools/buildbot/bin/python'} 03:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:57 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:57 INFO - Cleaning up... 03:15:57 INFO - Return code: 0 03:15:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:15:57 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:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:57 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:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:57 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 0x7ff4ce2fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d37410>, '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 0x1d38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d387a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', '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:57 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:57 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:57 INFO - Using env: {'DISPLAY': ':0', 03:15:57 INFO - 'HOME': '/home/cltbld', 03:15:57 INFO - 'LANG': 'en_US.UTF-8', 03:15:57 INFO - 'LANGUAGE': 'en_US:en', 03:15:57 INFO - 'LOGNAME': 'cltbld', 03:15:57 INFO - 'MAIL': '/var/mail/cltbld', 03:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:57 INFO - 'MOZ_NO_REMOTE': '1', 03:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:57 INFO - 'NO_EM_RESTART': '1', 03:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:57 INFO - 'PWD': '/builds/slave/test', 03:15:57 INFO - 'SHELL': '/bin/bash', 03:15:57 INFO - 'SHLVL': '1', 03:15:57 INFO - 'TERM': 'linux', 03:15:57 INFO - 'TMOUT': '86400', 03:15:57 INFO - 'USER': 'cltbld', 03:15:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', 03:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:57 INFO - '_': '/tools/buildbot/bin/python'} 03:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:57 INFO - Downloading/unpacking psutil>=0.7.1 03:15:57 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:57 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:57 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:57 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:57 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:57 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 - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:15:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:59 INFO - Installing collected packages: psutil 03:15:59 INFO - Running setup.py install for psutil 03:15:59 INFO - building 'psutil._psutil_linux' extension 03:15:59 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:16:00 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:16:00 INFO - building 'psutil._psutil_posix' extension 03:16:00 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:16:00 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:16:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:00 INFO - Successfully installed psutil 03:16:00 INFO - Cleaning up... 03:16:00 INFO - Return code: 0 03:16:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:00 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 0x7ff4ce2fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d37410>, '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 0x1d38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d387a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', '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:00 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:16:00 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:16:00 INFO - Using env: {'DISPLAY': ':0', 03:16:00 INFO - 'HOME': '/home/cltbld', 03:16:00 INFO - 'LANG': 'en_US.UTF-8', 03:16:00 INFO - 'LANGUAGE': 'en_US:en', 03:16:00 INFO - 'LOGNAME': 'cltbld', 03:16:00 INFO - 'MAIL': '/var/mail/cltbld', 03:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:00 INFO - 'MOZ_NO_REMOTE': '1', 03:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:00 INFO - 'NO_EM_RESTART': '1', 03:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:00 INFO - 'PWD': '/builds/slave/test', 03:16:00 INFO - 'SHELL': '/bin/bash', 03:16:00 INFO - 'SHLVL': '1', 03:16:00 INFO - 'TERM': 'linux', 03:16:00 INFO - 'TMOUT': '86400', 03:16:00 INFO - 'USER': 'cltbld', 03:16:00 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', 03:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:00 INFO - '_': '/tools/buildbot/bin/python'} 03:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:16:00 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:00 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 - 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:00 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:00 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:00 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:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:16:02 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:02 INFO - Installing collected packages: mozsystemmonitor 03:16:02 INFO - Running setup.py install for mozsystemmonitor 03:16:02 INFO - Successfully installed mozsystemmonitor 03:16:02 INFO - Cleaning up... 03:16:02 INFO - Return code: 0 03:16:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff4ce2fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d37410>, '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 0x1d38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d387a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', '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:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:16:02 INFO - Using env: {'DISPLAY': ':0', 03:16:02 INFO - 'HOME': '/home/cltbld', 03:16:02 INFO - 'LANG': 'en_US.UTF-8', 03:16:02 INFO - 'LANGUAGE': 'en_US:en', 03:16:02 INFO - 'LOGNAME': 'cltbld', 03:16:02 INFO - 'MAIL': '/var/mail/cltbld', 03:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:02 INFO - 'MOZ_NO_REMOTE': '1', 03:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:02 INFO - 'NO_EM_RESTART': '1', 03:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:02 INFO - 'PWD': '/builds/slave/test', 03:16:02 INFO - 'SHELL': '/bin/bash', 03:16:02 INFO - 'SHLVL': '1', 03:16:02 INFO - 'TERM': 'linux', 03:16:02 INFO - 'TMOUT': '86400', 03:16:02 INFO - 'USER': 'cltbld', 03:16:02 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', 03:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:02 INFO - '_': '/tools/buildbot/bin/python'} 03:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:02 INFO - Downloading/unpacking blobuploader==1.2.4 03:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:04 INFO - Downloading blobuploader-1.2.4.tar.gz 03:16:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:16:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:16:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:05 INFO - Downloading docopt-0.6.1.tar.gz 03:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:16:05 INFO - Installing collected packages: blobuploader, requests, docopt 03:16:05 INFO - Running setup.py install for blobuploader 03:16:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:16:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:16:05 INFO - Running setup.py install for requests 03:16:06 INFO - Running setup.py install for docopt 03:16:06 INFO - Successfully installed blobuploader requests docopt 03:16:06 INFO - Cleaning up... 03:16:06 INFO - Return code: 0 03:16:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:06 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:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:06 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:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:06 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 0x7ff4ce2fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d37410>, '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 0x1d38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d387a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', '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:06 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:06 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:06 INFO - Using env: {'DISPLAY': ':0', 03:16:06 INFO - 'HOME': '/home/cltbld', 03:16:06 INFO - 'LANG': 'en_US.UTF-8', 03:16:06 INFO - 'LANGUAGE': 'en_US:en', 03:16:06 INFO - 'LOGNAME': 'cltbld', 03:16:06 INFO - 'MAIL': '/var/mail/cltbld', 03:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:06 INFO - 'MOZ_NO_REMOTE': '1', 03:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:06 INFO - 'NO_EM_RESTART': '1', 03:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:06 INFO - 'PWD': '/builds/slave/test', 03:16:06 INFO - 'SHELL': '/bin/bash', 03:16:06 INFO - 'SHLVL': '1', 03:16:06 INFO - 'TERM': 'linux', 03:16:06 INFO - 'TMOUT': '86400', 03:16:06 INFO - 'USER': 'cltbld', 03:16:06 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', 03:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:06 INFO - '_': '/tools/buildbot/bin/python'} 03:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:06 INFO - Running setup.py (path:/tmp/pip-aYC_2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:06 INFO - Running setup.py (path:/tmp/pip-L_byQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:06 INFO - Running setup.py (path:/tmp/pip-pVWj9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:06 INFO - Running setup.py (path:/tmp/pip-A60FMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:06 INFO - Running setup.py (path:/tmp/pip-LbbqSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:06 INFO - Running setup.py (path:/tmp/pip-vT1doJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:06 INFO - Running setup.py (path:/tmp/pip-CYYjWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:06 INFO - Running setup.py (path:/tmp/pip-vswH9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:06 INFO - Running setup.py (path:/tmp/pip-l80aaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:07 INFO - Running setup.py (path:/tmp/pip-uhReSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:07 INFO - Running setup.py (path:/tmp/pip-wb1LMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:07 INFO - Running setup.py (path:/tmp/pip-3ComFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:07 INFO - Running setup.py (path:/tmp/pip-MCxAT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:07 INFO - Running setup.py (path:/tmp/pip-H3XEvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:07 INFO - Running setup.py (path:/tmp/pip-kGR1iX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:07 INFO - Running setup.py (path:/tmp/pip-c3GChF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:07 INFO - Running setup.py (path:/tmp/pip-JYJfMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:16:07 INFO - Running setup.py install for manifestparser 03:16:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:16:07 INFO - Running setup.py install for mozcrash 03:16:07 INFO - Running setup.py install for mozdebug 03:16:07 INFO - Running setup.py install for mozdevice 03:16:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:16:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:16:08 INFO - Running setup.py install for mozfile 03:16:08 INFO - Running setup.py install for mozhttpd 03:16:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:16:08 INFO - Running setup.py install for mozinfo 03:16:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:16:08 INFO - Running setup.py install for mozInstall 03:16:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:16:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:16:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:16:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:16:08 INFO - Running setup.py install for mozleak 03:16:08 INFO - Running setup.py install for mozlog 03:16:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:16:08 INFO - Running setup.py install for moznetwork 03:16:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:16:08 INFO - Running setup.py install for mozprocess 03:16:08 INFO - Running setup.py install for mozprofile 03:16:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:16:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:16:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:16:08 INFO - Running setup.py install for mozrunner 03:16:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:16:09 INFO - Running setup.py install for mozscreenshot 03:16:09 INFO - Running setup.py install for moztest 03:16:09 INFO - Running setup.py install for mozversion 03:16:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:16:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:16:09 INFO - Cleaning up... 03:16:09 INFO - Return code: 0 03:16:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:09 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:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:09 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:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:09 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 0x7ff4ce2fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d37410>, '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 0x1d38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d387a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', '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:09 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:09 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:09 INFO - Using env: {'DISPLAY': ':0', 03:16:09 INFO - 'HOME': '/home/cltbld', 03:16:09 INFO - 'LANG': 'en_US.UTF-8', 03:16:09 INFO - 'LANGUAGE': 'en_US:en', 03:16:09 INFO - 'LOGNAME': 'cltbld', 03:16:09 INFO - 'MAIL': '/var/mail/cltbld', 03:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:09 INFO - 'MOZ_NO_REMOTE': '1', 03:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:09 INFO - 'NO_EM_RESTART': '1', 03:16:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:09 INFO - 'PWD': '/builds/slave/test', 03:16:09 INFO - 'SHELL': '/bin/bash', 03:16:09 INFO - 'SHLVL': '1', 03:16:09 INFO - 'TERM': 'linux', 03:16:09 INFO - 'TMOUT': '86400', 03:16:09 INFO - 'USER': 'cltbld', 03:16:09 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', 03:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:09 INFO - '_': '/tools/buildbot/bin/python'} 03:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:09 INFO - Running setup.py (path:/tmp/pip-OWoQmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:09 INFO - Running setup.py (path:/tmp/pip-pisLdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:09 INFO - Running setup.py (path:/tmp/pip-zJeY7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:09 INFO - Running setup.py (path:/tmp/pip-HNYz4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:09 INFO - Running setup.py (path:/tmp/pip-oqYvyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:09 INFO - Running setup.py (path:/tmp/pip-R7HZWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:10 INFO - Running setup.py (path:/tmp/pip-1npKh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:10 INFO - Running setup.py (path:/tmp/pip-tdSJC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:10 INFO - Running setup.py (path:/tmp/pip-bjNJsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:10 INFO - Running setup.py (path:/tmp/pip-0kMfQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:10 INFO - Running setup.py (path:/tmp/pip-cQoL_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:10 INFO - Running setup.py (path:/tmp/pip-DP1GkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:10 INFO - Running setup.py (path:/tmp/pip-G_xtPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:10 INFO - Running setup.py (path:/tmp/pip-27BCwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:10 INFO - Running setup.py (path:/tmp/pip-1pQ_Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:10 INFO - Running setup.py (path:/tmp/pip-JXhyGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:10 INFO - Running setup.py (path:/tmp/pip-M_ncuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:10 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:10 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:10 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:10 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:10 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:10 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:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:12 INFO - Downloading blessings-1.6.tar.gz 03:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:16:12 INFO - Installing collected packages: blessings 03:16:12 INFO - Running setup.py install for blessings 03:16:12 INFO - Successfully installed blessings 03:16:12 INFO - Cleaning up... 03:16:12 INFO - Return code: 0 03:16:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:16:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:13 INFO - Reading from file tmpfile_stdout 03:16:13 INFO - Current package versions: 03:16:13 INFO - argparse == 1.2.1 03:16:13 INFO - blessings == 1.6 03:16:13 INFO - blobuploader == 1.2.4 03:16:13 INFO - docopt == 0.6.1 03:16:13 INFO - manifestparser == 1.1 03:16:13 INFO - mozInstall == 1.12 03:16:13 INFO - mozcrash == 0.17 03:16:13 INFO - mozdebug == 0.1 03:16:13 INFO - mozdevice == 0.48 03:16:13 INFO - mozfile == 1.2 03:16:13 INFO - mozhttpd == 0.7 03:16:13 INFO - mozinfo == 0.9 03:16:13 INFO - mozleak == 0.1 03:16:13 INFO - mozlog == 3.1 03:16:13 INFO - moznetwork == 0.27 03:16:13 INFO - mozprocess == 0.22 03:16:13 INFO - mozprofile == 0.28 03:16:13 INFO - mozrunner == 6.11 03:16:13 INFO - mozscreenshot == 0.1 03:16:13 INFO - mozsystemmonitor == 0.0 03:16:13 INFO - moztest == 0.7 03:16:13 INFO - mozversion == 1.4 03:16:13 INFO - psutil == 3.1.1 03:16:13 INFO - requests == 1.2.3 03:16:13 INFO - wsgiref == 0.1.2 03:16:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:13 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 0x7ff4ce2fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d37410>, '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 0x1d38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d387a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', '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:13 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:13 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:13 INFO - Using env: {'DISPLAY': ':0', 03:16:13 INFO - 'HOME': '/home/cltbld', 03:16:13 INFO - 'LANG': 'en_US.UTF-8', 03:16:13 INFO - 'LANGUAGE': 'en_US:en', 03:16:13 INFO - 'LOGNAME': 'cltbld', 03:16:13 INFO - 'MAIL': '/var/mail/cltbld', 03:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:13 INFO - 'MOZ_NO_REMOTE': '1', 03:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:13 INFO - 'NO_EM_RESTART': '1', 03:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:13 INFO - 'PWD': '/builds/slave/test', 03:16:13 INFO - 'SHELL': '/bin/bash', 03:16:13 INFO - 'SHLVL': '1', 03:16:13 INFO - 'TERM': 'linux', 03:16:13 INFO - 'TMOUT': '86400', 03:16:13 INFO - 'USER': 'cltbld', 03:16:13 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', 03:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:13 INFO - '_': '/tools/buildbot/bin/python'} 03:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:13 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:13 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:13 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:13 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:13 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:13 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:13 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:13 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:13 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:13 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:13 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:13 INFO - Cleaning up... 03:16:13 INFO - Return code: 0 03:16:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4ce2fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d37410>, '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 0x1d38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d387a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', '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:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:16:13 INFO - Using env: {'DISPLAY': ':0', 03:16:13 INFO - 'HOME': '/home/cltbld', 03:16:13 INFO - 'LANG': 'en_US.UTF-8', 03:16:13 INFO - 'LANGUAGE': 'en_US:en', 03:16:13 INFO - 'LOGNAME': 'cltbld', 03:16:13 INFO - 'MAIL': '/var/mail/cltbld', 03:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:13 INFO - 'MOZ_NO_REMOTE': '1', 03:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:13 INFO - 'NO_EM_RESTART': '1', 03:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:13 INFO - 'PWD': '/builds/slave/test', 03:16:13 INFO - 'SHELL': '/bin/bash', 03:16:13 INFO - 'SHLVL': '1', 03:16:13 INFO - 'TERM': 'linux', 03:16:13 INFO - 'TMOUT': '86400', 03:16:13 INFO - 'USER': 'cltbld', 03:16:13 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', 03:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:13 INFO - '_': '/tools/buildbot/bin/python'} 03:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:13 INFO - Downloading/unpacking jsonschema 03:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:16:15 INFO - Downloading/unpacking functools32 (from jsonschema) 03:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:15 INFO - Downloading functools32-3.2.3-2.tar.gz 03:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:16:15 INFO - warning: no files found matching '*.txt' 03:16:15 INFO - no previously-included directories found matching 'build' 03:16:15 INFO - no previously-included directories found matching 'dist' 03:16:15 INFO - no previously-included directories found matching '.git*' 03:16:15 INFO - Installing collected packages: jsonschema, functools32 03:16:15 INFO - Running setup.py install for functools32 03:16:15 INFO - warning: no files found matching '*.txt' 03:16:15 INFO - no previously-included directories found matching 'build' 03:16:15 INFO - no previously-included directories found matching 'dist' 03:16:15 INFO - no previously-included directories found matching '.git*' 03:16:15 INFO - Successfully installed jsonschema functools32 03:16:15 INFO - Cleaning up... 03:16:15 INFO - Return code: 0 03:16:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4ce2fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d37410>, '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 0x1d38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d387a0>, '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': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', '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:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:16:15 INFO - Using env: {'DISPLAY': ':0', 03:16:15 INFO - 'HOME': '/home/cltbld', 03:16:15 INFO - 'LANG': 'en_US.UTF-8', 03:16:15 INFO - 'LANGUAGE': 'en_US:en', 03:16:15 INFO - 'LOGNAME': 'cltbld', 03:16:15 INFO - 'MAIL': '/var/mail/cltbld', 03:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:15 INFO - 'MOZ_NO_REMOTE': '1', 03:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:15 INFO - 'NO_EM_RESTART': '1', 03:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:15 INFO - 'PWD': '/builds/slave/test', 03:16:15 INFO - 'SHELL': '/bin/bash', 03:16:15 INFO - 'SHLVL': '1', 03:16:15 INFO - 'TERM': 'linux', 03:16:15 INFO - 'TMOUT': '86400', 03:16:15 INFO - 'USER': 'cltbld', 03:16:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', 03:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:15 INFO - '_': '/tools/buildbot/bin/python'} 03:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:16 INFO - Downloading/unpacking 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 - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:16:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:16:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:16:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:16:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:16:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:16:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:16:18 INFO - no previously-included directories found matching 'docs/_build' 03:16:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:16:18 INFO - Running setup.py install for pep8 03:16:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:16:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:16:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:16:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:16:18 INFO - no previously-included directories found matching 'docs/_build' 03:16:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:16:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:16:18 INFO - Cleaning up... 03:16:18 INFO - Return code: 0 03:16:18 INFO - Running post-action listener: _resource_record_post_action 03:16:18 INFO - Running post-action listener: _start_resource_monitoring 03:16:18 INFO - Starting resource monitoring. 03:16:18 INFO - ##### 03:16:18 INFO - ##### Running install step. 03:16:18 INFO - ##### 03:16:18 INFO - Running pre-action listener: _resource_record_pre_action 03:16:18 INFO - Running main action method: install 03:16:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:19 INFO - Reading from file tmpfile_stdout 03:16:19 INFO - Detecting whether we're running mozinstall >=1.0... 03:16:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:16:19 INFO - Reading from file tmpfile_stdout 03:16:19 INFO - Output received: 03:16:19 INFO - Usage: mozinstall [options] installer 03:16:19 INFO - Options: 03:16:19 INFO - -h, --help show this help message and exit 03:16:19 INFO - -d DEST, --destination=DEST 03:16:19 INFO - Directory to install application into. [default: 03:16:19 INFO - "/builds/slave/test"] 03:16:19 INFO - --app=APP Application being installed. [default: firefox] 03:16:19 INFO - mkdir: /builds/slave/test/build/application 03:16:19 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:19 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:34 INFO - Reading from file tmpfile_stdout 03:16:34 INFO - Output received: 03:16:34 INFO - /builds/slave/test/build/application/firefox/firefox 03:16:34 INFO - Running post-action listener: _resource_record_post_action 03:16:34 INFO - ##### 03:16:34 INFO - ##### Running run-tests step. 03:16:34 INFO - ##### 03:16:34 INFO - Running pre-action listener: _resource_record_pre_action 03:16:34 INFO - Running main action method: run_tests 03:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:16:34 INFO - Python 2.7.3 03:16:34 INFO - Return code: 0 03:16:34 INFO - grabbing minidump binary from tooltool 03:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d37410>, '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 0x1d38310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d387a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:16:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:16:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:16:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:16:34 INFO - Return code: 0 03:16:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:16:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:16:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:16:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:16:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:16:35 INFO - Return code: 0 03:16:35 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-048', '--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:35 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-048 --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:35 INFO - Using env: {'DISPLAY': ':0', 03:16:35 INFO - 'HOME': '/home/cltbld', 03:16:35 INFO - 'LANG': 'en_US.UTF-8', 03:16:35 INFO - 'LANGUAGE': 'en_US:en', 03:16:35 INFO - 'LOGNAME': 'cltbld', 03:16:35 INFO - 'MAIL': '/var/mail/cltbld', 03:16:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:16:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:35 INFO - 'MOZ_NO_REMOTE': '1', 03:16:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:35 INFO - 'NO_EM_RESTART': '1', 03:16:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:35 INFO - 'PWD': '/builds/slave/test', 03:16:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:16:35 INFO - 'SHELL': '/bin/bash', 03:16:35 INFO - 'SHLVL': '1', 03:16:35 INFO - 'TERM': 'linux', 03:16:35 INFO - 'TMOUT': '86400', 03:16:35 INFO - 'USER': 'cltbld', 03:16:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349', 03:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:35 INFO - '_': '/tools/buildbot/bin/python'} 03:16:35 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-048', '--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:36 INFO - mozversion application_buildid: 20160505123841 03:16:36 INFO - mozversion application_changeset: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b 03:16:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:16:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:16:36 INFO - mozversion application_name: Firefox 03:16:36 INFO - mozversion application_remotingname: firefox-dev 03:16:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:16:36 INFO - mozversion application_vendor: Mozilla 03:16:36 INFO - mozversion application_version: 48.0a2 03:16:36 INFO - mozversion platform_buildid: 20160505123841 03:16:36 INFO - mozversion platform_changeset: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b 03:16:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:16:36 INFO - mozversion platform_version: 48.0a2 03:16:36 INFO - using testdate: 1462529796 03:16:36 INFO - actual date: 1462529796 03:16:36 INFO - starting webserver on 'localhost:42007' 03:16:36 INFO - SUITE-START | Running 2 tests 03:16:36 INFO - TEST-START | dromaeo_css 03:16:36 INFO - operating with platform_type : linux_ 03:16:36 INFO - Initialising browser for dromaeo_css test... 03:16:36 INFO - TEST-INFO | started process 12768 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP6N2gW/profile http://localhost:42007/getInfo.html) 03:16:40 INFO - PROCESS | 12768 | __metrics Screen width/height:1600/1200 03:16:40 INFO - PROCESS | 12768 | colorDepth:24 03:16:40 INFO - PROCESS | 12768 | Browser inner width/height: 1024/697 03:16:40 INFO - PROCESS | 12768 | __metrics 03:16:41 ERROR - PROCESS | 12768 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:16:42 INFO - TEST-INFO | 12768: exit 0 03:16:42 INFO - Browser initialized. 03:16:42 INFO - Running cycle 1/1 for dromaeo_css test... 03:16:42 INFO - TEST-INFO | started process 12859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP6N2gW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:54 INFO - PROCESS | 12859 | RSS: Main: 142331904 03:16:54 INFO - PROCESS | 12859 | 03:17:44 INFO - PROCESS | 12859 | 1462529864723 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:52 INFO - PROCESS | 12859 | Cycle 1(1): loaded http://localhost:42007/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42007/tests/dromaeo/cssquery-ext.html) 03:19:53 INFO - PROCESS | 12859 | RSS: Main: 265695232 03:19:53 INFO - PROCESS | 12859 | 03:22:56 INFO - PROCESS | 12859 | Cycle 1(1): loaded http://localhost:42007/tests/dromaeo/cssquery-ext.html (next: http://localhost:42007/tests/dromaeo/cssquery-jquery.html) 03:22:56 INFO - PROCESS | 12859 | RSS: Main: 222167040 03:22:56 INFO - PROCESS | 12859 | 03:25:58 INFO - PROCESS | 12859 | Cycle 1(1): loaded http://localhost:42007/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42007/tests/dromaeo/cssquery-mootools.html) 03:25:59 INFO - PROCESS | 12859 | RSS: Main: 218648576 03:25:59 INFO - PROCESS | 12859 | 03:29:00 INFO - PROCESS | 12859 | Cycle 1(1): loaded http://localhost:42007/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42007/tests/dromaeo/cssquery-prototype.html) 03:29:01 INFO - PROCESS | 12859 | RSS: Main: 220966912 03:29:01 INFO - PROCESS | 12859 | 03:32:04 INFO - PROCESS | 12859 | Cycle 1(1): loaded http://localhost:42007/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42007/tests/dromaeo/cssquery-yui.html) 03:32:04 INFO - PROCESS | 12859 | RSS: Main: 214298624 03:32:04 INFO - PROCESS | 12859 | 03:35:06 INFO - PROCESS | 12859 | Cycle 1(1): loaded http://localhost:42007/tests/dromaeo/cssquery-yui.html (next: http://localhost:42007/tests/dromaeo/cssquery-dojo.html) 03:35:07 INFO - PROCESS | 12859 | RSS: Main: 259039232 03:35:07 INFO - PROCESS | 12859 | 03:35:07 INFO - PROCESS | 12859 | __start_tp_report 03:35:07 INFO - PROCESS | 12859 | _x_x_mozilla_page_load 03:35:07 INFO - PROCESS | 12859 | _x_x_mozilla_page_load_details 03:35:07 INFO - PROCESS | 12859 | |i|pagename|runs| 03:35:07 INFO - PROCESS | 12859 | |0;dojo.html;3339.7328213742894;3347.815870127142;3366.8653253869848;3370.511275865001;3412.9317413651734;5476.26070480485;5510.201020851974;5512.5865560083;5524.917126243109;5535.723213839312;5465.59008074394;5529.695866727328;5536.058869992101;5539.556835453164;5540.944590554093;4959.652824302282;4979.950200498003;5018.422881368653;5047.47001564836;5087.364079490064;5066.873328166788;5074.112030394666;5131.486851314858;5140.971805638868;5146.716930568818;5045.21799121135;5110.616703747215;5114.923276150861;5122.8207012754565;5123.2315152727015;5135.871603209912;5147.639665223436;5157.510036546522;5164.04465173944;5174.042802081627;4898.853034408973;4947.257911313296;5031.77357018935;5057.064443078042;5084.44071152173;5395.10980688186;5397.892042159135;5399.9730001350135;5417.322834645669;5429.782808687648;5802.274715660543;5802.680852553108;5851.239338885917;5861.0915308127305;5863.560232982543;5899.882002359929;5905.645661260338;5923.378045305224;5959.851003724898;6023.578349515492;5591.02157122506;5594.832155035356;5598.608097433182;5604.775808967636;5624.746886390122;6059.303180134341;6060.181875446759;6064.151018857364;6067.848303792441;6091.817245482643;5704.543636509153;5754.280714910637;5815.214945982323;5853.64878107315;5869.970650146722;5881.9705901470215;5892.1161825726485;5901.822945311647;5902.1146827976145;5910.497607703307;5825.126231065374;5861.970690146607;5863.70681465925;5870.3249126350165;5875.676837773878;5834.358220595731;5839.649621022752;5882.3529411764675;5943.821685349447;5944.583879128506;4465.888352791141;4469.553044695569;4469.754163520973;4478.193925093449;4486.64106871456;4003.139325045129;4016.196760647882;4022.8994275143355;4026.074002979331;4036.6367026967714;5466.371367292732;5624.493795558419;5699.059655156935;5719.971400142973;5720.313562372542;5951.1073338999495;6000.969995149996;6001.099835024781;6001.459868611846;6005.549583781234;5493.450654934474;5671.092625179951;5674.233978412862;5679.914801277984;5681.34664513578;5105.412877519133;5160.948390516121;5165.819196328111;5169.689818610896;5186.688798672092;6184.721687524072;6197.287311959182;6202.596831205957;6206.131141640174;6208.627482351073;5734.455226753452;5902.734376952962;5987.401259873977;5990.7304171311525;5992.760289588367;6135.875804921915;6176.845578860564;6177.84555386119;6180.6291622502795;6185;5829.76680932758;5864.9413505866105;5876.294844618673;5878.735456904364;5898.1152827076285;5734.168545560954;5933.3769954154195;5969.7313620888035;5973.283206015132;6021.157038014594;5822.272215973004;5828.825135245949;5832.445917637818;5833.649981001154;5842.912356314744;5768.423157684198;5801.361850196559;5810.215620891126;5824;5824.184614153937;5620.044592419216;5664.37691853904;5707.857303567444;5710.857228569319;5748.770049198152;5853.765849365977;5858.794942177174;5860.531157507304;5866.853328666647;5882.1470886722045;5701.173329867063;5750.827475175752;5754.741036653444;5756.395578464201;5760.567957403127 03:35:07 INFO - PROCESS | 12859 | |1;ext.html;647.9740810367585;665.913431253937;667.1693741292092;675.5575098310609;684.674779479747;33735.32529349411;40274.59725402745;41064.79467602665;41236.79381603095;41317.79341103298;42929.57070429295;43705.781471092676;43729.12541749171;43790.34314485277;43913;8333.66665333386;8852.690155844546;9061.546922653873;9068.637254509844;10484.423356715377;10596.947015264914;10775.730606734855;10789.56841726334;10796;10797.244192906499;10667.78664426711;10797.352158870493;10798.946005269963;10804.945975270113;10812.621558245462;8291.751247462556;10376.377417354908;10646.787064258671;10676.466176691134;10701.304415212986;10571.048605625454;10694.572217111307;10703.197260205516;10709.036186743231;10709.464526773709;40295.19409611791;40994.590054099375;41137;41166;41213.79393103045;3818.3890577507464;3887.1253967857288;3944.9408258876138;3956.6439020488006;4207.957920420788;34512.13719657004;34734.305313893834;34820.82589587036;34885.30229395398;35177.12057198565;4462.59836614703;4596.49438561758;4605.217113090783;4617.215073437524;4692.014676917851;322128;322849;323666.3816680925;324320;324517;66203;66354.33645663482;66405.66797165983;66820;66824;70325;70403.64798176079;70625.2937470629;70880.2911970884;70936.290637094;18398.356057537923;19078.14148363327;19111.808881911;19130;19150.425487235127;12717.427715752814;13423.597292081058;13725.382357793924;13741;13746.518871839638;19539.80460195408;19601.765708657913;20335.288264910952;20515.974201289875;20536.07587658559;6584.703688334036;6724.4284235840505;6727.293634168342;6830.931690683129;6860.759873404407;1046.3460337289193;1096.270979798441;1193.2124797633521;1206.1315852586124;1276.8403949506312;33779.49330760041;33950.66049339475;34454.996794537255;34958.30083398318;35236;1187.3944288412972;1202.0864143251192;1236.6166488388628;1279.6161151654467;1300.109425043848;17539.210735516932;18379.540511487052;18475.076246187637;18485.815141848678;18509.167087481095;507806;508545;509538;510400;512249;62862.37137628657;63134.68432657807;63198;63267.36732632707;63281;1424.722179175051;1441.67562298482;1493.4623535526985;1559.9922000390152;1647.1105602974499;29713.554296686;30366.304201505267;33434;33943.151421214665;34449.13877153091;51342.74328628333;51571.742141289054;51759.48240517547;51805;51817.7409112952;314439;315616;315723;316198;316517;33423.83288083544;39399.40900886546;39695.40456893091;39889.40165897456;39916.40125398179;44118.33822492601;44262.55737442713;44446.555534445535;44789.552104478535;45392.31911521264;39586;40403.797981009906;41710;41714.165716686104;42852.57147428486;40194.59805401909;41014;41378.1724365517;41425;41559.1688166241;41980;42472;42840.57159428366;43335.783321084455;43624;36433.63566364408;37672.43491347577;38057.80971095127;38188.24163431467;38250.617493824706;27963.72036279611;29167.270818229714;29242.41515169727;29408.55887161737;29467.705322946495 03:35:07 INFO - PROCESS | 12859 | |2;jquery.html;424.14958009191605;429.63910315335113;432.3092189940951;439.18531124763564;443.6583830450553;18697.906510467445;19221.423357299285;19236.3267285645;20034.1986320547;20106.095225714842;19684;19873.60252794943;20037.1985120595;20561.383158505232;20572.89713551434;5850.970745146268;5905.852353691149;5958.28500579931;5984.251968503937;6002.999999999978;4337.609615134637;4999.375078115236;5805.709714514279;6562.179727534059;6766.391024807766;6496.123023391829;6553.705083271264;6611.272759996421;6622.304658010888;6638.236602790693;6414.615123092606;6535.967320163416;6551.4431273341825;6554.705038273265;6563;3901.2782635212575;5563.693996830173;5788.131780232957;5816.6219195752565;5826;24048;24127.396815079763;24271.7572824273;24371.7562824373;24852.5029499409;2592.183462209398;2644.444666620012;2725.9591106133425;3208.903732888017;3237.676232376767;11464.942675286653;14873.776893346609;14897.404103835834;15067.945243832826;15165.469208577757;1991.4623051776084;2078.418042947977;2132.72274604302;2148.967765483519;2149.7635260121374;80491.19508804896;81716.59141704314;81941;82959;83780;10602.734931626772;11353.54585816558;11439;11804;12105.576304829288;16259.83740162607;16307.184640767915;16378.181090945405;16385.83614163867;16389.42637007699;8779.29765618749;8788.912110878937;8919.152680495343;8956.925168979635;9005.369624126379;8784.824303513893;8814.647414103363;8865.113488651083;8936.8659470108;8947.955260223787;6902.861942761117;7045.823854403681;7049.118860142482;7109.644517774194;7161.749338773118;2005;2029.2998915374171;2035.4300795777206;2043.4891277180704;2044.7137400763606;1008.6016023670609;1094.1684319916922;1127.4193790198055;1135.3868910788083;1176.7352345722145;11937.761244775056;12285.508579656893;19986.300479483147;20555.177792888415;20614.381568552966;493.75065591875875;494.4610374691603;502.5728131088546;508;516.74679407091;6298.338674439209;6522.673866306665;6834.214065382445;6836.179658440919;6859.862802743917;496514;507833;518641;521153;525652;72594.63702681559;82938;90349;90916;94370.5281473602;512.6488355476511;515.1705753736481;517.2551525802832;517.4902720819989;520.336570872141;11406.885931140583;11440.656780296604;11478.65648337085;11628.18602697803;11714;40720.592794072865;41210.79394603128;41428.79285603553;41586;42098.158036839704;52490;53276.46723532715;62622;62860.68569657122;63670.36329636644;8884.244839188741;9279.953600231956;9321.906780932104;9405.482698451377;9601.37591056579;9587.904120958701;10931.672049838518;12220.961218296188;13084.084114112302;13883.791743123658;12460.501579936701;12591.370431478206;12719.93640031831;12721.80917286223;12794.296313702464;12072.215306005082;12212.938935305267;12364.876351236733;12618.936905315415;12732.172408793398;12567.68580785451;12576.245425274512;12603.87396126027;12775.488980440678;13041.347932603521;8812.779680508038;9206.079392061009;9241.445513269226;9315.86026209594;9545.236381089357;11878.168528202943;12188;12340.136190466941;12460.065495087723;12495.0003999678 03:35:07 INFO - PROCESS | 12859 | |3;mootools.html;1425.223253326938;1579.8104227492702;1625.1305551529933;1777.893326400416;1908.847292216623;8408.579571021448;8761.211490965812;8774.210321071103;8779.209871111607;8801.251893589037;8434.662613495453;8527.658893644262;8620.568971551413;8623.482591044542;8627.439216450943;2096.7379077615296;2374.513224788923;2377.4531857672746;2412.6622272881723;2446.71862735785;2427.9150229741963;2436.8294219404647;2439.609662454008;2440.389902524369;2442.767937045987;2342.3324352559525;2394.0663141374876;2396.077510158584;2397.4246180916543;2400.327908185711;2062.0411508648476;2347.1667558016916;2417.02110645189;2419.5765740995257;2422.9273121806373;2316.0504193280844;2318.397216723647;2327.2785436514564;2329.7670232976734;2350.847194932324;8297.875531867026;8318.251357377865;8366.414350995432;8383.664653413856;8387.580620968989;5148.3821941366905;5297.735113244323;5298.443663415324;5300.443453437372;5400.864978375572;3319.8008119512906;3322.401967645823;3396.728261739055;3461.446168613035;3479.425894727367;1012.4836333469909;1086.3536195963388;1099.725068732817;1111.7998760223156;1133.257716195893;11895.286282823145;11962.58130965412;11965.820512692317;11975.28148311104;12000.279983200948;4787.976060119677;4792.257200133985;4796.665250847044;4813.807447702123;4833.371661683958;10310.226732995055;10345.12066474343;10355.378677279386;10357.430341331148;10388.636397726043;4924.384451943507;5409.107497262986;5423.538999185034;5426.565874730012;5429.701366424884;4824.228123500223;4894.706317620954;4898.632602554822;4920.581750551171;4925.408950925912;4172.7704976226;4204.474440694913;4218.409422680827;4241.618254357123;4346.521882592912;1334.9132306400247;1350.5070649212967;1350.9054366194273;1356.7829147336577;1377.758892193862;1029.5109822834095;1053.7154968158554;1056.5034433816095;1060.4114716332356;1071.1858987169808;5979.491743201789;6316.115743795872;6360.268569114611;6375.234971803413;6429.935700643027;958.343917953007;966.9226461883032;991.6777047459605;998.381003777648;1049.6431213387484;4002.519697636244;4149.875503734893;4154.459920210354;4248.787560622019;4461.643068554573;11040.503177357039;11377.317360958203;11402.885971140347;11466.31202127875;11467.942660286646;11065.391403472886;11141.832872506919;11245.887541124484;11285.322880627189;11312.490937907814;8263.917360826435;8266.669333226724;8291.502509849308;8338.958305208434;8367.079621241659;6007.87984240304;6045.274567051982;6147.354527774698;6191.690415479298;6249.125122482947;9554.28342874301;9674.467904265051;9822;9954.402735835873;10033.548490317808;9809.845564634243;9922.900770992486;10309.381437113798;10375.740606484898;10410.843837342294;8008.639611217625;8075.232852878967;8155.510669359857;8185.386096042702;8202.83594328122;8670.91329086701;8719.171678690514;8731.694390696295;8764.123587641185;8809.559522023745;8020.719274825353;8098.676052957816;8117.553534555656;8159.224873636995;8209.958950205211;7673.155952845294;7683.731069412544;7710.614469276402;7794.2985131338455;7996;7294.781156565312;7637.4653774237495;7642.8089297768;7643.770686879402;7643.847123057619;5291.523762861361;5304.07178743726;5306.363236411656;5402.918956215582;5556;5281.419043905091;5312.681239125664;5323.254744335719;5325.520703136736;5369.946300536944 03:35:07 INFO - PROCESS | 12859 | |4;prototype.html;335.5587402565626;345.1974160077819;351.40261555355886;351.72038229607466;351.90146758907485;5451.972740136299;5482.7258637068135;5511.118221084627;5550.47270509302;5564.276644036279;5432.266644003058;5458.9454105458935;5467.589930755199;5474.7810087596445;5506.779728810843;4111.403846442279;4346.217680817467;4348.456442944632;4350.173467041268;4361.956380436187;3876.4185372194115;4143.005678637121;4187.937180942288;4239.809208585606;4251.341042138473;4238.689913996864;4253.064325848309;4266.317389217726;4285.171786620831;4292.883850198939;4245.893852653678;4260.552641972595;4280.486341639008;4296.183725092223;4296.8281268749215;3580.785152890835;3584.318979393907;3665.890023299305;3692.9446058309145;3780.6219378061974;5240.772671614549;5310.92033619496;5314;5316.920246196271;5348.411674715778;4879.853234489892;4880.633952453581;4895.632827537949;4923.901521969577;4932.753362331869;5559.63862348946;5635.690037047961;5713.285839270091;5714.200026991484;5736.627119237236;4131.9173616527805;4148.937765933513;4157.4201803314845;4167.895212917458;4182.707210495267;5635.464630860103;5714.685692286964;5989.431004054608;6062.151298818169;6067.484263837579;4206.453161089039;4248.957510424918;4253.723507971972;4278.7860606969525;4297.119090586422;4318.870433886988;4329.134173165379;4349.238883195429;4351.6518678505645;4352.760598167131;4899.559039686445;4914.557689807934;4931;4936.48166942473;4958.578520825698;5688.829335119953;5768.077107662753;5799.710014499258;5807.5644326675665;5833;1575.6213313350818;1575.6848630273992;1581.1540825658217;1588.563145135074;1592.8486793754576;1061.2147011211648;1062.5802807890839;1080.6487891435315;1092.229977865603;1101.3942331717524;5895.115732640138;5929.347771745104;5937.604662904214;5955.493783028491;5970.940290597126;6210.4100110489435;6232.376762323732;6264.342244064399;6268.717907694165;6325.715342809584;5754.727347191581;5950.047992321294;5951.3751056139345;5975.38489214028;6004;3326.268220991378;3343.164208947763;3344.1973926257524;3359.3113411750533;3383.796972181677;5889.204957330706;6251.624902505864;6287.182666253358;6538.346165383518;6556.147700798961;6032.939670603326;6076.301225359052;6076.8784624308155;6094.573379863456;6103.572749907553;5933.910991335133;6020.187274717945;6163.8150855474405;6247.75008999644;6262.906056409158;5908.645481271137;5951.345352011189;5957.523398128053;5973.492253158356;5976.551758618034;5626.212330273846;5919.6744179070565;5958.880822383615;5966.254218222723;5968.194293770459;6219.108114726674;6232.8130156095385;6238.6880655967925;6256.468200202851;6280.685965701788;4208.053188032668;4265.84822098038;4269.124829409901;4277.443932288783;4285.635720963628;5858.209141765807;5990.760369585168;6025.457708806229;6070.391346293324;6109.908351374644;5800.4489573490455;5814.796482123105;5869.119632055226;5877.529797616095;5878.647281163144;5718.685472299064;5846.649201047951;5869.4717475427415;5870;5891.263592050994;5733.054046082517;5777.364489906191;5783.971080144573;5789.884202316014;5795.82612521625;5892.145638882253;5892.852678682896;5917.940820591739;5921.14143449206;5928.8814223716145;5569.6936668482;5777.3933736957015;5785.3636100028125;5790.826275211751;5791.420857914175 03:35:07 INFO - PROCESS | 12859 | |5;yui.html;848.5502683577706;880.7225723896976;908.0919080919078;908.9818203635928;925.9166674999249;14618.415263389465;14734.18961957092;14769.556913292592;15029.774553381709;15259.61850953728;13985.720285594281;14086.506972255973;14102.717945641081;14135.505257315996;14163.362648680808;739.7299985505306;765.2500549461531;768.34690513064;878.4246318661287;890.5947793753859;758.4425447296261;860.0840105287848;885.7829831691245;891;891.7859713668705;938.5025936253762;944.9952750236239;946.096477863642;947.900470450603;951.1392190068;763.8434121005181;927.6521304510809;927.6799504171084;927.689224109924;930.4975313330793;669.0399277037467;684.1926526698494;689.4553302890711;690.5062880040795;691.2258270736756;14285.78571321431;14588.635284117981;14600.415983360654;14664.633384165374;14903.850961490463;14765.483208087666;15262;15265.313060912285;15354.385824567004;15440.150791706452;11508.94245528767;11580.88419115815;11773;11807.173497855154;11896.286222826659;3916.099297161669;3953.723239373245;3969.4442778011103;3994.800259986989;4012.779297138656;51055.744721276526;52037.47962520364;52136.47863521354;52151;52346;10859.674209773719;11361;11476.368799716096;11749;11841.703957400961;18835.623287534447;18855.717164242546;18912.71630925537;18922.33771818007;18969.33607323737;8261.297789687944;8439.156084391512;8568.271696905707;8681.262092722063;8686;4936.679115857458;5010.223415370623;5049.772760225798;5169.095408303532;5206.062908676475;3539.2744487380023;3633.473146393811;3651.2514934438377;3669.7064234861145;3672.485851980725;670.7652321687468;677.6069879469895;678.6504949950779;683.1494788987742;686.543448606681;677.3226773226774;706.3678008182751;709.9918116274902;713.7252157919238;754.2683596910988;9523.857142142873;9529.285303602257;9583.712488625353;9658.179054780281;9754.804903901882;666.2171947961126;693.2132030145721;710.3358359933479;726.6076318787901;736.717733848309;4465;4553.954460455419;4647.814087436464;4657.953420465752;4695.765211739467;62288.37711622826;63073;63927;64481.67759161174;64490;55539;56219.718901405235;57949.71025144847;58077;58236.41763582395;52117.739411302704;53864.46135538673;54037.72981135069;54138;54502.72748636232;9385.624575016924;9936.552855121681;10191.847122293024;10423.94788026055;10436.686899392727;33974.15064623404;34818;35829.32722245788;36269.81865090658;37081;45241.54758452373;46034.76982615065;46831.76584117058;46978.29532557083;48023;12820;12900.8064879025;13063.346832658139;13208.735825283633;13371.264580448169;13683.179009259477;14068.859311406755;14242.430302787772;14296.642583935485;15246.847531524543;14005;14060.296985150906;14082.225477598831;14168.716625667636;14402.567922962327;13340.332983350987;13396.866031339561;13534.93232533831;13636.859919204886;13892.207188519944;13673.79489307681;13807.654808629864;13843.307834608027;13851.722965540834;13936.930315348358;11501.597444089417;11516.481758321062;11612.303261804318;11701.531938722355;11751.118666099906;11039.68166684973;11101.278416902875;11202.327860328407;11352.489137988645;11681.06551475863 03:35:07 INFO - PROCESS | 12859 | __end_tp_report 03:35:07 INFO - PROCESS | 12859 | __start_cc_report 03:35:07 INFO - PROCESS | 12859 | _x_x_mozilla_cycle_collect,843 03:35:07 INFO - PROCESS | 12859 | __end_cc_report 03:35:07 INFO - PROCESS | 12859 | __startTimestamp1462530907223__endTimestamp 03:35:07 INFO - PROCESS | 12859 | 03:35:07 INFO - PROCESS | 12859 | ------- Summary: start ------- 03:35:07 INFO - PROCESS | 12859 | Number of tests: 6 03:35:07 INFO - PROCESS | 12859 | 03:35:07 INFO - PROCESS | 12859 | [#0] dojo.html Cycles:165 Average:5516.84 Median:5734.46 stddev:609.69 (10.6%) stddev-sans-first:587.15 03:35:07 INFO - PROCESS | 12859 | Values: 3339.7 3347.8 3366.9 3370.5 3412.9 5476.3 5510.2 5512.6 5524.9 5535.7 5465.6 5529.7 5536.1 5539.6 5540.9 4959.7 4980.0 5018.4 5047.5 5087.4 5066.9 5074.1 5131.5 5141.0 5146.7 5045.2 5110.6 5114.9 5122.8 5123.2 5135.9 5147.6 5157.5 5164.0 5174.0 4898.9 4947.3 5031.8 5057.1 5084.4 5395.1 5397.9 5400.0 5417.3 5429.8 5802.3 5802.7 5851.2 5861.1 5863.6 5899.9 5905.6 5923.4 5959.9 6023.6 5591.0 5594.8 5598.6 5604.8 5624.7 6059.3 6060.2 6064.2 6067.8 6091.8 5704.5 5754.3 5815.2 5853.6 5870.0 5882.0 5892.1 5901.8 5902.1 5910.5 5825.1 5862.0 5863.7 5870.3 5875.7 5834.4 5839.6 5882.4 5943.8 5944.6 4465.9 4469.6 4469.8 4478.2 4486.6 4003.1 4016.2 4022.9 4026.1 4036.6 5466.4 5624.5 5699.1 5720.0 5720.3 5951.1 6001.0 6001.1 6001.5 6005.5 5493.5 5671.1 5674.2 5679.9 5681.3 5105.4 5160.9 5165.8 5169.7 5186.7 6184.7 6197.3 6202.6 6206.1 6208.6 5734.5 5902.7 5987.4 5990.7 5992.8 6135.9 6176.8 6177.8 6180.6 6185.0 5829.8 5864.9 5876.3 5878.7 5898.1 5734.2 5933.4 5969.7 5973.3 6021.2 5822.3 5828.8 5832.4 5833.6 5842.9 5768.4 5801.4 5810.2 5824.0 5824.2 5620.0 5664.4 5707.9 5710.9 5748.8 5853.8 5858.8 5860.5 5866.9 5882.1 5701.2 5750.8 5754.7 5756.4 5760.6 03:35:07 INFO - PROCESS | 12859 | 03:35:07 INFO - PROCESS | 12859 | [#1] ext.html Cycles:180 Average:56775.73 Median:21003.32 stddev:103786.80 (494.1%) stddev-sans-first:103992.40 03:35:07 INFO - PROCESS | 12859 | Values: 648.0 665.9 667.2 675.6 684.7 33735.3 40274.6 41064.8 41236.8 41317.8 42929.6 43705.8 43729.1 43790.3 43913.0 8333.7 8852.7 9061.5 9068.6 10484.4 10596.9 10775.7 10789.6 10796.0 10797.2 10667.8 10797.4 10798.9 10804.9 10812.6 8291.8 10376.4 10646.8 10676.5 10701.3 10571.0 10694.6 10703.2 10709.0 10709.5 40295.2 40994.6 41137.0 41166.0 41213.8 3818.4 3887.1 3944.9 3956.6 4208.0 34512.1 34734.3 34820.8 34885.3 35177.1 4462.6 4596.5 4605.2 4617.2 4692.0 322128.0 322849.0 323666.4 324320.0 324517.0 66203.0 66354.3 66405.7 66820.0 66824.0 70325.0 70403.6 70625.3 70880.3 70936.3 18398.4 19078.1 19111.8 19130.0 19150.4 12717.4 13423.6 13725.4 13741.0 13746.5 19539.8 19601.8 20335.3 20516.0 20536.1 6584.7 6724.4 6727.3 6830.9 6860.8 1046.3 1096.3 1193.2 1206.1 1276.8 33779.5 33950.7 34455.0 34958.3 35236.0 1187.4 1202.1 1236.6 1279.6 1300.1 17539.2 18379.5 18475.1 18485.8 18509.2 507806.0 508545.0 509538.0 510400.0 512249.0 62862.4 63134.7 63198.0 63267.4 63281.0 1424.7 1441.7 1493.5 1560.0 1647.1 29713.6 30366.3 33434.0 33943.2 34449.1 51342.7 51571.7 51759.5 51805.0 51817.7 314439.0 315616.0 315723.0 316198.0 316517.0 33423.8 39399.4 39695.4 39889.4 39916.4 44118.3 44262.6 44446.6 44789.6 45392.3 39586.0 40403.8 41710.0 41714.2 42852.6 40194.6 41014.0 41378.2 41425.0 41559.2 41980.0 42472.0 42840.6 43335.8 43624.0 36433.6 37672.4 38057.8 38188.2 38250.6 27963.7 29167.3 29242.4 29408.6 29467.7 03:35:07 INFO - PROCESS | 12859 | 03:35:07 INFO - PROCESS | 12859 | [#2] jquery.html Cycles:180 Average:29697.21 Median:426.89 stddev:84530.55 (19801.3%) stddev-sans-first:84739.11 03:35:07 INFO - PROCESS | 12859 | Values: 424.1 429.6 432.3 439.2 443.7 18697.9 19221.4 19236.3 20034.2 20106.1 19684.0 19873.6 20037.2 20561.4 20572.9 5851.0 5905.9 5958.3 5984.3 6003.0 4337.6 4999.4 5805.7 6562.2 6766.4 6496.1 6553.7 6611.3 6622.3 6638.2 6414.6 6536.0 6551.4 6554.7 6563.0 3901.3 5563.7 5788.1 5816.6 5826.0 24048.0 24127.4 24271.8 24371.8 24852.5 2592.2 2644.4 2726.0 3208.9 3237.7 11464.9 14873.8 14897.4 15067.9 15165.5 1991.5 2078.4 2132.7 2149.0 2149.8 80491.2 81716.6 81941.0 82959.0 83780.0 10602.7 11353.5 11439.0 11804.0 12105.6 16259.8 16307.2 16378.2 16385.8 16389.4 8779.3 8788.9 8919.2 8956.9 9005.4 8784.8 8814.6 8865.1 8936.9 8948.0 6902.9 7045.8 7049.1 7109.6 7161.7 2005.0 2029.3 2035.4 2043.5 2044.7 1008.6 1094.2 1127.4 1135.4 1176.7 11937.8 12285.5 19986.3 20555.2 20614.4 493.8 494.5 502.6 508.0 516.7 6298.3 6522.7 6834.2 6836.2 6859.9 496514.0 507833.0 518641.0 521153.0 525652.0 72594.6 82938.0 90349.0 90916.0 94370.5 512.6 515.2 517.3 517.5 520.3 11406.9 11440.7 11478.7 11628.2 11714.0 40720.6 41210.8 41428.8 41586.0 42098.2 52490.0 53276.5 62622.0 62860.7 63670.4 8884.2 9280.0 9321.9 9405.5 9601.4 9587.9 10931.7 12221.0 13084.1 13883.8 12460.5 12591.4 12719.9 12721.8 12794.3 12072.2 12212.9 12364.9 12618.9 12732.2 12567.7 12576.2 12603.9 12775.5 13041.3 8812.8 9206.1 9241.4 9315.9 9545.2 11878.2 12188.0 12340.1 12460.1 12495.0 03:35:07 INFO - PROCESS | 12859 | 03:35:07 INFO - PROCESS | 12859 | [#3] mootools.html Cycles:180 Average:5898.49 Median:4864.04 stddev:3286.92 (67.6%) stddev-sans-first:3278.94 03:35:07 INFO - PROCESS | 12859 | Values: 1425.2 1579.8 1625.1 1777.9 1908.8 8408.6 8761.2 8774.2 8779.2 8801.3 8434.7 8527.7 8620.6 8623.5 8627.4 2096.7 2374.5 2377.5 2412.7 2446.7 2427.9 2436.8 2439.6 2440.4 2442.8 2342.3 2394.1 2396.1 2397.4 2400.3 2062.0 2347.2 2417.0 2419.6 2422.9 2316.1 2318.4 2327.3 2329.8 2350.8 8297.9 8318.3 8366.4 8383.7 8387.6 5148.4 5297.7 5298.4 5300.4 5400.9 3319.8 3322.4 3396.7 3461.4 3479.4 1012.5 1086.4 1099.7 1111.8 1133.3 11895.3 11962.6 11965.8 11975.3 12000.3 4788.0 4792.3 4796.7 4813.8 4833.4 10310.2 10345.1 10355.4 10357.4 10388.6 4924.4 5409.1 5423.5 5426.6 5429.7 4824.2 4894.7 4898.6 4920.6 4925.4 4172.8 4204.5 4218.4 4241.6 4346.5 1334.9 1350.5 1350.9 1356.8 1377.8 1029.5 1053.7 1056.5 1060.4 1071.2 5979.5 6316.1 6360.3 6375.2 6429.9 958.3 966.9 991.7 998.4 1049.6 4002.5 4149.9 4154.5 4248.8 4461.6 11040.5 11377.3 11402.9 11466.3 11467.9 11065.4 11141.8 11245.9 11285.3 11312.5 8263.9 8266.7 8291.5 8339.0 8367.1 6007.9 6045.3 6147.4 6191.7 6249.1 9554.3 9674.5 9822.0 9954.4 10033.5 9809.8 9922.9 10309.4 10375.7 10410.8 8008.6 8075.2 8155.5 8185.4 8202.8 8670.9 8719.2 8731.7 8764.1 8809.6 8020.7 8098.7 8117.6 8159.2 8210.0 7673.2 7683.7 7710.6 7794.3 7996.0 7294.8 7637.5 7642.8 7643.8 7643.8 5291.5 5304.1 5306.4 5402.9 5556.0 5281.4 5312.7 5323.3 5325.5 5369.9 03:35:07 INFO - PROCESS | 12859 | 03:35:07 INFO - PROCESS | 12859 | [#4] prototype.html Cycles:180 Average:4925.94 Median:5566.99 stddev:1450.55 (26.1%) stddev-sans-first:1413.10 03:35:07 INFO - PROCESS | 12859 | Values: 335.6 345.2 351.4 351.7 351.9 5452.0 5482.7 5511.1 5550.5 5564.3 5432.3 5458.9 5467.6 5474.8 5506.8 4111.4 4346.2 4348.5 4350.2 4362.0 3876.4 4143.0 4187.9 4239.8 4251.3 4238.7 4253.1 4266.3 4285.2 4292.9 4245.9 4260.6 4280.5 4296.2 4296.8 3580.8 3584.3 3665.9 3692.9 3780.6 5240.8 5310.9 5314.0 5316.9 5348.4 4879.9 4880.6 4895.6 4923.9 4932.8 5559.6 5635.7 5713.3 5714.2 5736.6 4131.9 4148.9 4157.4 4167.9 4182.7 5635.5 5714.7 5989.4 6062.2 6067.5 4206.5 4249.0 4253.7 4278.8 4297.1 4318.9 4329.1 4349.2 4351.7 4352.8 4899.6 4914.6 4931.0 4936.5 4958.6 5688.8 5768.1 5799.7 5807.6 5833.0 1575.6 1575.7 1581.2 1588.6 1592.8 1061.2 1062.6 1080.6 1092.2 1101.4 5895.1 5929.3 5937.6 5955.5 5970.9 6210.4 6232.4 6264.3 6268.7 6325.7 5754.7 5950.0 5951.4 5975.4 6004.0 3326.3 3343.2 3344.2 3359.3 3383.8 5889.2 6251.6 6287.2 6538.3 6556.1 6032.9 6076.3 6076.9 6094.6 6103.6 5933.9 6020.2 6163.8 6247.8 6262.9 5908.6 5951.3 5957.5 5973.5 5976.6 5626.2 5919.7 5958.9 5966.3 5968.2 6219.1 6232.8 6238.7 6256.5 6280.7 4208.1 4265.8 4269.1 4277.4 4285.6 5858.2 5990.8 6025.5 6070.4 6109.9 5800.4 5814.8 5869.1 5877.5 5878.6 5718.7 5846.6 5869.5 5870.0 5891.3 5733.1 5777.4 5784.0 5789.9 5795.8 5892.1 5892.9 5917.9 5921.1 5928.9 5569.7 5777.4 5785.4 5790.8 5791.4 03:35:07 INFO - PROCESS | 12859 | 03:35:07 INFO - PROCESS | 12859 | [#5] yui.html Cycles:180 Average:15391.68 Median:25294.36 stddev:17432.27 (68.9%) stddev-sans-first:17446.95 03:35:07 INFO - PROCESS | 12859 | Values: 848.6 880.7 908.1 909.0 925.9 14618.4 14734.2 14769.6 15029.8 15259.6 13985.7 14086.5 14102.7 14135.5 14163.4 739.7 765.3 768.3 878.4 890.6 758.4 860.1 885.8 891.0 891.8 938.5 945.0 946.1 947.9 951.1 763.8 927.7 927.7 927.7 930.5 669.0 684.2 689.5 690.5 691.2 14285.8 14588.6 14600.4 14664.6 14903.9 14765.5 15262.0 15265.3 15354.4 15440.2 11508.9 11580.9 11773.0 11807.2 11896.3 3916.1 3953.7 3969.4 3994.8 4012.8 51055.7 52037.5 52136.5 52151.0 52346.0 10859.7 11361.0 11476.4 11749.0 11841.7 18835.6 18855.7 18912.7 18922.3 18969.3 8261.3 8439.2 8568.3 8681.3 8686.0 4936.7 5010.2 5049.8 5169.1 5206.1 3539.3 3633.5 3651.3 3669.7 3672.5 670.8 677.6 678.7 683.1 686.5 677.3 706.4 710.0 713.7 754.3 9523.9 9529.3 9583.7 9658.2 9754.8 666.2 693.2 710.3 726.6 736.7 4465.0 4554.0 4647.8 4658.0 4695.8 62288.4 63073.0 63927.0 64481.7 64490.0 55539.0 56219.7 57949.7 58077.0 58236.4 52117.7 53864.5 54037.7 54138.0 54502.7 9385.6 9936.6 10191.8 10423.9 10436.7 33974.2 34818.0 35829.3 36269.8 37081.0 45241.5 46034.8 46831.8 46978.3 48023.0 12820.0 12900.8 13063.3 13208.7 13371.3 13683.2 14068.9 14242.4 14296.6 15246.8 14005.0 14060.3 14082.2 14168.7 14402.6 13340.3 13396.9 13534.9 13636.9 13892.2 13673.8 13807.7 13843.3 13851.7 13936.9 11501.6 11516.5 11612.3 11701.5 11751.1 11039.7 11101.3 11202.3 11352.5 11681.1 03:35:07 INFO - PROCESS | 12859 | -------- Summary: end -------- 03:35:07 INFO - PROCESS | 12859 | 03:35:07 INFO - TEST-INFO | 12859: exit 0 03:35:07 INFO - TEST-OK | dromaeo_css | took 1111877ms 03:35:07 INFO - TEST-START | kraken 03:35:07 INFO - operating with platform_type : linux_ 03:35:07 INFO - Initialising browser for kraken test... 03:35:07 INFO - TEST-INFO | started process 13053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeD85z3/profile http://localhost:42007/getInfo.html) 03:35:12 INFO - PROCESS | 13053 | __metrics Screen width/height:1600/1200 03:35:12 INFO - PROCESS | 13053 | colorDepth:24 03:35:12 INFO - PROCESS | 13053 | Browser inner width/height: 1024/697 03:35:12 INFO - PROCESS | 13053 | __metrics 03:35:13 ERROR - PROCESS | 13053 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:35:13 INFO - TEST-INFO | 13053: exit 0 03:35:13 INFO - Browser initialized. 03:35:13 INFO - Running cycle 1/1 for kraken test... 03:35:13 INFO - TEST-INFO | started process 13147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeD85z3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:25 INFO - PROCESS | 13147 | RSS: Main: 142270464 03:35:25 INFO - PROCESS | 13147 | 03:35:28 INFO - PROCESS | 13147 | Cycle 1(1): loaded http://localhost:42007/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42007/tests/kraken/driver.html?testName=audio-beat-detection) 03:35:29 INFO - PROCESS | 13147 | RSS: Main: 190341120 03:35:29 INFO - PROCESS | 13147 | 03:35:31 INFO - PROCESS | 13147 | Cycle 1(1): loaded http://localhost:42007/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42007/tests/kraken/driver.html?testName=audio-dft) 03:35:32 INFO - PROCESS | 13147 | RSS: Main: 184410112 03:35:32 INFO - PROCESS | 13147 | 03:35:35 INFO - PROCESS | 13147 | Cycle 1(1): loaded http://localhost:42007/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42007/tests/kraken/driver.html?testName=audio-fft) 03:35:35 INFO - PROCESS | 13147 | RSS: Main: 272527360 03:35:35 INFO - PROCESS | 13147 | 03:35:37 INFO - PROCESS | 13147 | Cycle 1(1): loaded http://localhost:42007/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42007/tests/kraken/driver.html?testName=audio-oscillator) 03:35:38 INFO - PROCESS | 13147 | RSS: Main: 181645312 03:35:38 INFO - PROCESS | 13147 | 03:35:40 INFO - PROCESS | 13147 | Cycle 1(1): loaded http://localhost:42007/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42007/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:35:41 INFO - PROCESS | 13147 | RSS: Main: 180449280 03:35:41 INFO - PROCESS | 13147 | 03:35:44 INFO - PROCESS | 13147 | Cycle 1(1): loaded http://localhost:42007/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42007/tests/kraken/driver.html?testName=imaging-darkroom) 03:35:44 INFO - PROCESS | 13147 | RSS: Main: 215343104 03:35:44 INFO - PROCESS | 13147 | 03:35:48 INFO - PROCESS | 13147 | Cycle 1(1): loaded http://localhost:42007/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42007/tests/kraken/driver.html?testName=imaging-desaturate) 03:35:48 INFO - PROCESS | 13147 | RSS: Main: 214978560 03:35:48 INFO - PROCESS | 13147 | 03:35:51 INFO - PROCESS | 13147 | Cycle 1(1): loaded http://localhost:42007/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42007/tests/kraken/driver.html?testName=json-parse-financial) 03:35:52 INFO - PROCESS | 13147 | RSS: Main: 214130688 03:35:52 INFO - PROCESS | 13147 | 03:35:53 INFO - PROCESS | 13147 | Cycle 1(1): loaded http://localhost:42007/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42007/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:35:54 INFO - PROCESS | 13147 | RSS: Main: 194834432 03:35:54 INFO - PROCESS | 13147 | 03:35:55 INFO - PROCESS | 13147 | Cycle 1(1): loaded http://localhost:42007/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42007/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:35:56 INFO - PROCESS | 13147 | RSS: Main: 197763072 03:35:56 INFO - PROCESS | 13147 | 03:35:58 INFO - PROCESS | 13147 | Cycle 1(1): loaded http://localhost:42007/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42007/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:35:59 INFO - PROCESS | 13147 | RSS: Main: 206782464 03:35:59 INFO - PROCESS | 13147 | 03:36:01 INFO - PROCESS | 13147 | Cycle 1(1): loaded http://localhost:42007/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:36:02 INFO - PROCESS | 13147 | RSS: Main: 214302720 03:36:02 INFO - PROCESS | 13147 | 03:36:05 INFO - PROCESS | 13147 | Cycle 1(1): loaded http://localhost:42007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:36:05 INFO - PROCESS | 13147 | RSS: Main: 210575360 03:36:05 INFO - PROCESS | 13147 | 03:36:07 INFO - PROCESS | 13147 | Cycle 1(1): loaded http://localhost:42007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42007/tests/kraken/driver.html?testName=ai-astar) 03:36:07 INFO - PROCESS | 13147 | RSS: Main: 273817600 03:36:07 INFO - PROCESS | 13147 | 03:36:07 INFO - PROCESS | 13147 | __start_tp_report 03:36:07 INFO - PROCESS | 13147 | _x_x_mozilla_page_load 03:36:07 INFO - PROCESS | 13147 | _x_x_mozilla_page_load_details 03:36:07 INFO - PROCESS | 13147 | |i|pagename|runs| 03:36:07 INFO - PROCESS | 13147 | |0;ai-astar;110;112;105;108;110;110;101;112;109;109 03:36:07 INFO - PROCESS | 13147 | |1;audio-beat-detection;158;128;152;190;137;155;151;126;187;126 03:36:07 INFO - PROCESS | 13147 | |2;audio-dft;161;161;166;161;162;158;163;163;160;161 03:36:07 INFO - PROCESS | 13147 | |3;audio-fft;73;77;77;167;74;78;76;73;168;76 03:36:07 INFO - PROCESS | 13147 | |4;audio-oscillator;92;92;147;91;91;93;152;92;92;151 03:36:07 INFO - PROCESS | 13147 | |5;imaging-gaussian-blur;117;117;116;118;117;117;117;117;117;117 03:36:07 INFO - PROCESS | 13147 | |6;imaging-darkroom;145;144;145;145;146;145;144;146;145;145 03:36:07 INFO - PROCESS | 13147 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;94;94 03:36:07 INFO - PROCESS | 13147 | |8;json-parse-financial;56;57;58;58;59;57;57;77;58;56 03:36:07 INFO - PROCESS | 13147 | |9;json-stringify-tinderbox;58;60;58;58;58;58;59;58;58;58 03:36:07 INFO - PROCESS | 13147 | |10;stanford-crypto-aes;74;74;73;73;74;74;73;74;74;73 03:36:07 INFO - PROCESS | 13147 | |11;stanford-crypto-ccm;124;127;119;121;127;117;116;118;158;125 03:36:07 INFO - PROCESS | 13147 | |12;stanford-crypto-pbkdf2;159;158;161;157;158;161;167;163;165;159 03:36:07 INFO - PROCESS | 13147 | |13;stanford-crypto-sha256-iterative;66;67;66;67;67;67;66;65;64;67 03:36:07 INFO - PROCESS | 13147 | __end_tp_report 03:36:07 INFO - PROCESS | 13147 | __start_cc_report 03:36:07 INFO - PROCESS | 13147 | _x_x_mozilla_cycle_collect,1617 03:36:07 INFO - PROCESS | 13147 | __end_cc_report 03:36:07 INFO - PROCESS | 13147 | __startTimestamp1462530967561__endTimestamp 03:36:07 INFO - PROCESS | 13147 | 03:36:07 INFO - PROCESS | 13147 | ------- Summary: start ------- 03:36:07 INFO - PROCESS | 13147 | Number of tests: 14 03:36:07 INFO - PROCESS | 13147 | 03:36:07 INFO - PROCESS | 13147 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.34 (3.0%) stddev-sans-first:3.50 03:36:07 INFO - PROCESS | 13147 | Values: 110.0 112.0 105.0 108.0 110.0 110.0 101.0 112.0 109.0 109.0 03:36:07 INFO - PROCESS | 13147 | 03:36:07 INFO - PROCESS | 13147 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:153.50 stddev:23.23 (15.1%) stddev-sans-first:24.50 03:36:07 INFO - PROCESS | 13147 | Values: 158.0 128.0 152.0 190.0 137.0 155.0 151.0 126.0 187.0 126.0 03:36:07 INFO - PROCESS | 13147 | 03:36:07 INFO - PROCESS | 13147 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:2.12 (1.3%) stddev-sans-first:2.24 03:36:07 INFO - PROCESS | 13147 | Values: 161.0 161.0 166.0 161.0 162.0 158.0 163.0 163.0 160.0 161.0 03:36:07 INFO - PROCESS | 13147 | 03:36:07 INFO - PROCESS | 13147 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:38.83 (51.1%) stddev-sans-first:40.44 03:36:07 INFO - PROCESS | 13147 | Values: 73.0 77.0 77.0 167.0 74.0 78.0 76.0 73.0 168.0 76.0 03:36:07 INFO - PROCESS | 13147 | 03:36:07 INFO - PROCESS | 13147 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:92.00 stddev:28.12 (30.6%) stddev-sans-first:29.12 03:36:07 INFO - PROCESS | 13147 | Values: 92.0 92.0 147.0 91.0 91.0 93.0 152.0 92.0 92.0 151.0 03:36:07 INFO - PROCESS | 13147 | 03:36:07 INFO - PROCESS | 13147 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 03:36:07 INFO - PROCESS | 13147 | Values: 117.0 117.0 116.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 03:36:07 INFO - PROCESS | 13147 | 03:36:07 INFO - PROCESS | 13147 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 03:36:07 INFO - PROCESS | 13147 | Values: 145.0 144.0 145.0 145.0 146.0 145.0 144.0 146.0 145.0 145.0 03:36:07 INFO - PROCESS | 13147 | 03:36:07 INFO - PROCESS | 13147 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:36:07 INFO - PROCESS | 13147 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 94.0 03:36:07 INFO - PROCESS | 13147 | 03:36:07 INFO - PROCESS | 13147 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:58.00 stddev:6.29 (10.8%) stddev-sans-first:6.56 03:36:07 INFO - PROCESS | 13147 | Values: 56.0 57.0 58.0 58.0 59.0 57.0 57.0 77.0 58.0 56.0 03:36:07 INFO - PROCESS | 13147 | 03:36:07 INFO - PROCESS | 13147 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 03:36:07 INFO - PROCESS | 13147 | Values: 58.0 60.0 58.0 58.0 58.0 58.0 59.0 58.0 58.0 58.0 03:36:07 INFO - PROCESS | 13147 | 03:36:07 INFO - PROCESS | 13147 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:74.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 03:36:07 INFO - PROCESS | 13147 | Values: 74.0 74.0 73.0 73.0 74.0 74.0 73.0 74.0 74.0 73.0 03:36:07 INFO - PROCESS | 13147 | 03:36:07 INFO - PROCESS | 13147 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:124.50 stddev:12.22 (9.8%) stddev-sans-first:12.95 03:36:07 INFO - PROCESS | 13147 | Values: 124.0 127.0 119.0 121.0 127.0 117.0 116.0 118.0 158.0 125.0 03:36:07 INFO - PROCESS | 13147 | 03:36:07 INFO - PROCESS | 13147 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:161.00 stddev:3.29 (2.0%) stddev-sans-first:3.43 03:36:07 INFO - PROCESS | 13147 | Values: 159.0 158.0 161.0 157.0 158.0 161.0 167.0 163.0 165.0 159.0 03:36:07 INFO - PROCESS | 13147 | 03:36:07 INFO - PROCESS | 13147 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 03:36:07 INFO - PROCESS | 13147 | Values: 66.0 67.0 66.0 67.0 67.0 67.0 66.0 65.0 64.0 67.0 03:36:07 INFO - PROCESS | 13147 | -------- Summary: end -------- 03:36:07 INFO - PROCESS | 13147 | 03:36:08 INFO - TEST-INFO | 13147: exit 0 03:36:08 INFO - TEST-OK | kraken | took 60594ms 03:36:08 INFO - SUITE-END | took 1172s 03:36:08 INFO - Completed test suite (00:19:32) 03:36:08 INFO - javascript benchmark 03:36:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3339.7328213742894, 3347.815870127142, 3366.8653253869848, 3370.511275865001, 3412.9317413651734, 5476.26070480485, 5510.201020851974, 5512.5865560083, 5524.917126243109, 5535.723213839312, 5465.59008074394, 5529.695866727328, 5536.058869992101, 5539.556835453164, 5540.944590554093, 4959.652824302282, 4979.950200498003, 5018.422881368653, 5047.47001564836, 5087.364079490064, 5066.873328166788, 5074.112030394666, 5131.486851314858, 5140.971805638868, 5146.716930568818, 5045.21799121135, 5110.616703747215, 5114.923276150861, 5122.8207012754565, 5123.2315152727015, 5135.871603209912, 5147.639665223436, 5157.510036546522, 5164.04465173944, 5174.042802081627, 4898.853034408973, 4947.257911313296, 5031.77357018935, 5057.064443078042, 5084.44071152173, 5395.10980688186, 5397.892042159135, 5399.9730001350135, 5417.322834645669, 5429.782808687648, 5802.274715660543, 5802.680852553108, 5851.239338885917, 5861.0915308127305, 5863.560232982543, 5899.882002359929, 5905.645661260338, 5923.378045305224, 5959.851003724898, 6023.578349515492, 5591.02157122506, 5594.832155035356, 5598.608097433182, 5604.775808967636, 5624.746886390122, 6059.303180134341, 6060.181875446759, 6064.151018857364, 6067.848303792441, 6091.817245482643, 5704.543636509153, 5754.280714910637, 5815.214945982323, 5853.64878107315, 5869.970650146722, 5881.9705901470215, 5892.1161825726485, 5901.822945311647, 5902.1146827976145, 5910.497607703307, 5825.126231065374, 5861.970690146607, 5863.70681465925, 5870.3249126350165, 5875.676837773878, 5834.358220595731, 5839.649621022752, 5882.3529411764675, 5943.821685349447, 5944.583879128506, 4465.888352791141, 4469.553044695569, 4469.754163520973, 4478.193925093449, 4486.64106871456, 4003.139325045129, 4016.196760647882, 4022.8994275143355, 4026.074002979331, 4036.6367026967714, 5466.371367292732, 5624.493795558419, 5699.059655156935, 5719.971400142973, 5720.313562372542, 5951.1073338999495, 6000.969995149996, 6001.099835024781, 6001.459868611846, 6005.549583781234, 5493.450654934474, 5671.092625179951, 5674.233978412862, 5679.914801277984, 5681.34664513578, 5105.412877519133, 5160.948390516121, 5165.819196328111, 5169.689818610896, 5186.688798672092, 6184.721687524072, 6197.287311959182, 6202.596831205957, 6206.131141640174, 6208.627482351073, 5734.455226753452, 5902.734376952962, 5987.401259873977, 5990.7304171311525, 5992.760289588367, 6135.875804921915, 6176.845578860564, 6177.84555386119, 6180.6291622502795, 6185.0, 5829.76680932758, 5864.9413505866105, 5876.294844618673, 5878.735456904364, 5898.1152827076285, 5734.168545560954, 5933.3769954154195, 5969.7313620888035, 5973.283206015132, 6021.157038014594, 5822.272215973004, 5828.825135245949, 5832.445917637818, 5833.649981001154, 5842.912356314744, 5768.423157684198, 5801.361850196559, 5810.215620891126, 5824.0, 5824.184614153937, 5620.044592419216, 5664.37691853904, 5707.857303567444, 5710.857228569319, 5748.770049198152, 5853.765849365977, 5858.794942177174, 5860.531157507304, 5866.853328666647, 5882.1470886722045, 5701.173329867063, 5750.827475175752, 5754.741036653444, 5756.395578464201, 5760.567957403127], "value": 5477.407934677139, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.9740810367585, 665.913431253937, 667.1693741292092, 675.5575098310609, 684.674779479747, 33735.32529349411, 40274.59725402745, 41064.79467602665, 41236.79381603095, 41317.79341103298, 42929.57070429295, 43705.781471092676, 43729.12541749171, 43790.34314485277, 43913.0, 8333.66665333386, 8852.690155844546, 9061.546922653873, 9068.637254509844, 10484.423356715377, 10596.947015264914, 10775.730606734855, 10789.56841726334, 10796.0, 10797.244192906499, 10667.78664426711, 10797.352158870493, 10798.946005269963, 10804.945975270113, 10812.621558245462, 8291.751247462556, 10376.377417354908, 10646.787064258671, 10676.466176691134, 10701.304415212986, 10571.048605625454, 10694.572217111307, 10703.197260205516, 10709.036186743231, 10709.464526773709, 40295.19409611791, 40994.590054099375, 41137.0, 41166.0, 41213.79393103045, 3818.3890577507464, 3887.1253967857288, 3944.9408258876138, 3956.6439020488006, 4207.957920420788, 34512.13719657004, 34734.305313893834, 34820.82589587036, 34885.30229395398, 35177.12057198565, 4462.59836614703, 4596.49438561758, 4605.217113090783, 4617.215073437524, 4692.014676917851, 322128.0, 322849.0, 323666.3816680925, 324320.0, 324517.0, 66203.0, 66354.33645663482, 66405.66797165983, 66820.0, 66824.0, 70325.0, 70403.64798176079, 70625.2937470629, 70880.2911970884, 70936.290637094, 18398.356057537923, 19078.14148363327, 19111.808881911, 19130.0, 19150.425487235127, 12717.427715752814, 13423.597292081058, 13725.382357793924, 13741.0, 13746.518871839638, 19539.80460195408, 19601.765708657913, 20335.288264910952, 20515.974201289875, 20536.07587658559, 6584.703688334036, 6724.4284235840505, 6727.293634168342, 6830.931690683129, 6860.759873404407, 1046.3460337289193, 1096.270979798441, 1193.2124797633521, 1206.1315852586124, 1276.8403949506312, 33779.49330760041, 33950.66049339475, 34454.996794537255, 34958.30083398318, 35236.0, 1187.3944288412972, 1202.0864143251192, 1236.6166488388628, 1279.6161151654467, 1300.109425043848, 17539.210735516932, 18379.540511487052, 18475.076246187637, 18485.815141848678, 18509.167087481095, 507806.0, 508545.0, 509538.0, 510400.0, 512249.0, 62862.37137628657, 63134.68432657807, 63198.0, 63267.36732632707, 63281.0, 1424.722179175051, 1441.67562298482, 1493.4623535526985, 1559.9922000390152, 1647.1105602974499, 29713.554296686, 30366.304201505267, 33434.0, 33943.151421214665, 34449.13877153091, 51342.74328628333, 51571.742141289054, 51759.48240517547, 51805.0, 51817.7409112952, 314439.0, 315616.0, 315723.0, 316198.0, 316517.0, 33423.83288083544, 39399.40900886546, 39695.40456893091, 39889.40165897456, 39916.40125398179, 44118.33822492601, 44262.55737442713, 44446.555534445535, 44789.552104478535, 45392.31911521264, 39586.0, 40403.797981009906, 41710.0, 41714.165716686104, 42852.57147428486, 40194.59805401909, 41014.0, 41378.1724365517, 41425.0, 41559.1688166241, 41980.0, 42472.0, 42840.57159428366, 43335.783321084455, 43624.0, 36433.63566364408, 37672.43491347577, 38057.80971095127, 38188.24163431467, 38250.617493824706, 27963.72036279611, 29167.270818229714, 29242.41515169727, 29408.55887161737, 29467.705322946495], "value": 21222.568317572397, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.14958009191605, 429.63910315335113, 432.3092189940951, 439.18531124763564, 443.6583830450553, 18697.906510467445, 19221.423357299285, 19236.3267285645, 20034.1986320547, 20106.095225714842, 19684.0, 19873.60252794943, 20037.1985120595, 20561.383158505232, 20572.89713551434, 5850.970745146268, 5905.852353691149, 5958.28500579931, 5984.251968503937, 6002.999999999978, 4337.609615134637, 4999.375078115236, 5805.709714514279, 6562.179727534059, 6766.391024807766, 6496.123023391829, 6553.705083271264, 6611.272759996421, 6622.304658010888, 6638.236602790693, 6414.615123092606, 6535.967320163416, 6551.4431273341825, 6554.705038273265, 6563.0, 3901.2782635212575, 5563.693996830173, 5788.131780232957, 5816.6219195752565, 5826.0, 24048.0, 24127.396815079763, 24271.7572824273, 24371.7562824373, 24852.5029499409, 2592.183462209398, 2644.444666620012, 2725.9591106133425, 3208.903732888017, 3237.676232376767, 11464.942675286653, 14873.776893346609, 14897.404103835834, 15067.945243832826, 15165.469208577757, 1991.4623051776084, 2078.418042947977, 2132.72274604302, 2148.967765483519, 2149.7635260121374, 80491.19508804896, 81716.59141704314, 81941.0, 82959.0, 83780.0, 10602.734931626772, 11353.54585816558, 11439.0, 11804.0, 12105.576304829288, 16259.83740162607, 16307.184640767915, 16378.181090945405, 16385.83614163867, 16389.42637007699, 8779.29765618749, 8788.912110878937, 8919.152680495343, 8956.925168979635, 9005.369624126379, 8784.824303513893, 8814.647414103363, 8865.113488651083, 8936.8659470108, 8947.955260223787, 6902.861942761117, 7045.823854403681, 7049.118860142482, 7109.644517774194, 7161.749338773118, 2005.0, 2029.2998915374171, 2035.4300795777206, 2043.4891277180704, 2044.7137400763606, 1008.6016023670609, 1094.1684319916922, 1127.4193790198055, 1135.3868910788083, 1176.7352345722145, 11937.761244775056, 12285.508579656893, 19986.300479483147, 20555.177792888415, 20614.381568552966, 493.75065591875875, 494.4610374691603, 502.5728131088546, 508.0, 516.74679407091, 6298.338674439209, 6522.673866306665, 6834.214065382445, 6836.179658440919, 6859.862802743917, 496514.0, 507833.0, 518641.0, 521153.0, 525652.0, 72594.63702681559, 82938.0, 90349.0, 90916.0, 94370.5281473602, 512.6488355476511, 515.1705753736481, 517.2551525802832, 517.4902720819989, 520.336570872141, 11406.885931140583, 11440.656780296604, 11478.65648337085, 11628.18602697803, 11714.0, 40720.592794072865, 41210.79394603128, 41428.79285603553, 41586.0, 42098.158036839704, 52490.0, 53276.46723532715, 62622.0, 62860.68569657122, 63670.36329636644, 8884.244839188741, 9279.953600231956, 9321.906780932104, 9405.482698451377, 9601.37591056579, 9587.904120958701, 10931.672049838518, 12220.961218296188, 13084.084114112302, 13883.791743123658, 12460.501579936701, 12591.370431478206, 12719.93640031831, 12721.80917286223, 12794.296313702464, 12072.215306005082, 12212.938935305267, 12364.876351236733, 12618.936905315415, 12732.172408793398, 12567.68580785451, 12576.245425274512, 12603.87396126027, 12775.488980440678, 13041.347932603521, 8812.779680508038, 9206.079392061009, 9241.445513269226, 9315.86026209594, 9545.236381089357, 11878.168528202943, 12188.0, 12340.136190466941, 12460.065495087723, 12495.0003999678], "value": 9203.427422528197, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1425.223253326938, 1579.8104227492702, 1625.1305551529933, 1777.893326400416, 1908.847292216623, 8408.579571021448, 8761.211490965812, 8774.210321071103, 8779.209871111607, 8801.251893589037, 8434.662613495453, 8527.658893644262, 8620.568971551413, 8623.482591044542, 8627.439216450943, 2096.7379077615296, 2374.513224788923, 2377.4531857672746, 2412.6622272881723, 2446.71862735785, 2427.9150229741963, 2436.8294219404647, 2439.609662454008, 2440.389902524369, 2442.767937045987, 2342.3324352559525, 2394.0663141374876, 2396.077510158584, 2397.4246180916543, 2400.327908185711, 2062.0411508648476, 2347.1667558016916, 2417.02110645189, 2419.5765740995257, 2422.9273121806373, 2316.0504193280844, 2318.397216723647, 2327.2785436514564, 2329.7670232976734, 2350.847194932324, 8297.875531867026, 8318.251357377865, 8366.414350995432, 8383.664653413856, 8387.580620968989, 5148.3821941366905, 5297.735113244323, 5298.443663415324, 5300.443453437372, 5400.864978375572, 3319.8008119512906, 3322.401967645823, 3396.728261739055, 3461.446168613035, 3479.425894727367, 1012.4836333469909, 1086.3536195963388, 1099.725068732817, 1111.7998760223156, 1133.257716195893, 11895.286282823145, 11962.58130965412, 11965.820512692317, 11975.28148311104, 12000.279983200948, 4787.976060119677, 4792.257200133985, 4796.665250847044, 4813.807447702123, 4833.371661683958, 10310.226732995055, 10345.12066474343, 10355.378677279386, 10357.430341331148, 10388.636397726043, 4924.384451943507, 5409.107497262986, 5423.538999185034, 5426.565874730012, 5429.701366424884, 4824.228123500223, 4894.706317620954, 4898.632602554822, 4920.581750551171, 4925.408950925912, 4172.7704976226, 4204.474440694913, 4218.409422680827, 4241.618254357123, 4346.521882592912, 1334.9132306400247, 1350.5070649212967, 1350.9054366194273, 1356.7829147336577, 1377.758892193862, 1029.5109822834095, 1053.7154968158554, 1056.5034433816095, 1060.4114716332356, 1071.1858987169808, 5979.491743201789, 6316.115743795872, 6360.268569114611, 6375.234971803413, 6429.935700643027, 958.343917953007, 966.9226461883032, 991.6777047459605, 998.381003777648, 1049.6431213387484, 4002.519697636244, 4149.875503734893, 4154.459920210354, 4248.787560622019, 4461.643068554573, 11040.503177357039, 11377.317360958203, 11402.885971140347, 11466.31202127875, 11467.942660286646, 11065.391403472886, 11141.832872506919, 11245.887541124484, 11285.322880627189, 11312.490937907814, 8263.917360826435, 8266.669333226724, 8291.502509849308, 8338.958305208434, 8367.079621241659, 6007.87984240304, 6045.274567051982, 6147.354527774698, 6191.690415479298, 6249.125122482947, 9554.28342874301, 9674.467904265051, 9822.0, 9954.402735835873, 10033.548490317808, 9809.845564634243, 9922.900770992486, 10309.381437113798, 10375.740606484898, 10410.843837342294, 8008.639611217625, 8075.232852878967, 8155.510669359857, 8185.386096042702, 8202.83594328122, 8670.91329086701, 8719.171678690514, 8731.694390696295, 8764.123587641185, 8809.559522023745, 8020.719274825353, 8098.676052957816, 8117.553534555656, 8159.224873636995, 8209.958950205211, 7673.155952845294, 7683.731069412544, 7710.614469276402, 7794.2985131338455, 7996.0, 7294.781156565312, 7637.4653774237495, 7642.8089297768, 7643.770686879402, 7643.847123057619, 5291.523762861361, 5304.07178743726, 5306.363236411656, 5402.918956215582, 5556.0, 5281.419043905091, 5312.681239125664, 5323.254744335719, 5325.520703136736, 5369.946300536944], "value": 4751.254681760644, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.5587402565626, 345.1974160077819, 351.40261555355886, 351.72038229607466, 351.90146758907485, 5451.972740136299, 5482.7258637068135, 5511.118221084627, 5550.47270509302, 5564.276644036279, 5432.266644003058, 5458.9454105458935, 5467.589930755199, 5474.7810087596445, 5506.779728810843, 4111.403846442279, 4346.217680817467, 4348.456442944632, 4350.173467041268, 4361.956380436187, 3876.4185372194115, 4143.005678637121, 4187.937180942288, 4239.809208585606, 4251.341042138473, 4238.689913996864, 4253.064325848309, 4266.317389217726, 4285.171786620831, 4292.883850198939, 4245.893852653678, 4260.552641972595, 4280.486341639008, 4296.183725092223, 4296.8281268749215, 3580.785152890835, 3584.318979393907, 3665.890023299305, 3692.9446058309145, 3780.6219378061974, 5240.772671614549, 5310.92033619496, 5314.0, 5316.920246196271, 5348.411674715778, 4879.853234489892, 4880.633952453581, 4895.632827537949, 4923.901521969577, 4932.753362331869, 5559.63862348946, 5635.690037047961, 5713.285839270091, 5714.200026991484, 5736.627119237236, 4131.9173616527805, 4148.937765933513, 4157.4201803314845, 4167.895212917458, 4182.707210495267, 5635.464630860103, 5714.685692286964, 5989.431004054608, 6062.151298818169, 6067.484263837579, 4206.453161089039, 4248.957510424918, 4253.723507971972, 4278.7860606969525, 4297.119090586422, 4318.870433886988, 4329.134173165379, 4349.238883195429, 4351.6518678505645, 4352.760598167131, 4899.559039686445, 4914.557689807934, 4931.0, 4936.48166942473, 4958.578520825698, 5688.829335119953, 5768.077107662753, 5799.710014499258, 5807.5644326675665, 5833.0, 1575.6213313350818, 1575.6848630273992, 1581.1540825658217, 1588.563145135074, 1592.8486793754576, 1061.2147011211648, 1062.5802807890839, 1080.6487891435315, 1092.229977865603, 1101.3942331717524, 5895.115732640138, 5929.347771745104, 5937.604662904214, 5955.493783028491, 5970.940290597126, 6210.4100110489435, 6232.376762323732, 6264.342244064399, 6268.717907694165, 6325.715342809584, 5754.727347191581, 5950.047992321294, 5951.3751056139345, 5975.38489214028, 6004.0, 3326.268220991378, 3343.164208947763, 3344.1973926257524, 3359.3113411750533, 3383.796972181677, 5889.204957330706, 6251.624902505864, 6287.182666253358, 6538.346165383518, 6556.147700798961, 6032.939670603326, 6076.301225359052, 6076.8784624308155, 6094.573379863456, 6103.572749907553, 5933.910991335133, 6020.187274717945, 6163.8150855474405, 6247.75008999644, 6262.906056409158, 5908.645481271137, 5951.345352011189, 5957.523398128053, 5973.492253158356, 5976.551758618034, 5626.212330273846, 5919.6744179070565, 5958.880822383615, 5966.254218222723, 5968.194293770459, 6219.108114726674, 6232.8130156095385, 6238.6880655967925, 6256.468200202851, 6280.685965701788, 4208.053188032668, 4265.84822098038, 4269.124829409901, 4277.443932288783, 4285.635720963628, 5858.209141765807, 5990.760369585168, 6025.457708806229, 6070.391346293324, 6109.908351374644, 5800.4489573490455, 5814.796482123105, 5869.119632055226, 5877.529797616095, 5878.647281163144, 5718.685472299064, 5846.649201047951, 5869.4717475427415, 5870.0, 5891.263592050994, 5733.054046082517, 5777.364489906191, 5783.971080144573, 5789.884202316014, 5795.82612521625, 5892.145638882253, 5892.852678682896, 5917.940820591739, 5921.14143449206, 5928.8814223716145, 5569.6936668482, 5777.3933736957015, 5785.3636100028125, 5790.826275211751, 5791.420857914175], "value": 4473.0835155204095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [848.5502683577706, 880.7225723896976, 908.0919080919078, 908.9818203635928, 925.9166674999249, 14618.415263389465, 14734.18961957092, 14769.556913292592, 15029.774553381709, 15259.61850953728, 13985.720285594281, 14086.506972255973, 14102.717945641081, 14135.505257315996, 14163.362648680808, 739.7299985505306, 765.2500549461531, 768.34690513064, 878.4246318661287, 890.5947793753859, 758.4425447296261, 860.0840105287848, 885.7829831691245, 891.0, 891.7859713668705, 938.5025936253762, 944.9952750236239, 946.096477863642, 947.900470450603, 951.1392190068, 763.8434121005181, 927.6521304510809, 927.6799504171084, 927.689224109924, 930.4975313330793, 669.0399277037467, 684.1926526698494, 689.4553302890711, 690.5062880040795, 691.2258270736756, 14285.78571321431, 14588.635284117981, 14600.415983360654, 14664.633384165374, 14903.850961490463, 14765.483208087666, 15262.0, 15265.313060912285, 15354.385824567004, 15440.150791706452, 11508.94245528767, 11580.88419115815, 11773.0, 11807.173497855154, 11896.286222826659, 3916.099297161669, 3953.723239373245, 3969.4442778011103, 3994.800259986989, 4012.779297138656, 51055.744721276526, 52037.47962520364, 52136.47863521354, 52151.0, 52346.0, 10859.674209773719, 11361.0, 11476.368799716096, 11749.0, 11841.703957400961, 18835.623287534447, 18855.717164242546, 18912.71630925537, 18922.33771818007, 18969.33607323737, 8261.297789687944, 8439.156084391512, 8568.271696905707, 8681.262092722063, 8686.0, 4936.679115857458, 5010.223415370623, 5049.772760225798, 5169.095408303532, 5206.062908676475, 3539.2744487380023, 3633.473146393811, 3651.2514934438377, 3669.7064234861145, 3672.485851980725, 670.7652321687468, 677.6069879469895, 678.6504949950779, 683.1494788987742, 686.543448606681, 677.3226773226774, 706.3678008182751, 709.9918116274902, 713.7252157919238, 754.2683596910988, 9523.857142142873, 9529.285303602257, 9583.712488625353, 9658.179054780281, 9754.804903901882, 666.2171947961126, 693.2132030145721, 710.3358359933479, 726.6076318787901, 736.717733848309, 4465.0, 4553.954460455419, 4647.814087436464, 4657.953420465752, 4695.765211739467, 62288.37711622826, 63073.0, 63927.0, 64481.67759161174, 64490.0, 55539.0, 56219.718901405235, 57949.71025144847, 58077.0, 58236.41763582395, 52117.739411302704, 53864.46135538673, 54037.72981135069, 54138.0, 54502.72748636232, 9385.624575016924, 9936.552855121681, 10191.847122293024, 10423.94788026055, 10436.686899392727, 33974.15064623404, 34818.0, 35829.32722245788, 36269.81865090658, 37081.0, 45241.54758452373, 46034.76982615065, 46831.76584117058, 46978.29532557083, 48023.0, 12820.0, 12900.8064879025, 13063.346832658139, 13208.735825283633, 13371.264580448169, 13683.179009259477, 14068.859311406755, 14242.430302787772, 14296.642583935485, 15246.847531524543, 14005.0, 14060.296985150906, 14082.225477598831, 14168.716625667636, 14402.567922962327, 13340.332983350987, 13396.866031339561, 13534.93232533831, 13636.859919204886, 13892.207188519944, 13673.79489307681, 13807.654808629864, 13843.307834608027, 13851.722965540834, 13936.930315348358, 11501.597444089417, 11516.481758321062, 11612.303261804318, 11701.531938722355, 11751.118666099906, 11039.68166684973, 11101.278416902875, 11202.327860328407, 11352.489137988645, 11681.06551475863], "value": 7102.313467223468, "unit": "score"}], "name": "dromaeo_css", "value": 7379.555559126462, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 105.0, 108.0, 110.0, 110.0, 101.0, 112.0, 109.0, 109.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 128.0, 152.0, 190.0, 137.0, 155.0, 151.0, 126.0, 187.0, 126.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 166.0, 161.0, 162.0, 158.0, 163.0, 163.0, 160.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 77.0, 167.0, 74.0, 78.0, 76.0, 73.0, 168.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 147.0, 91.0, 91.0, 93.0, 152.0, 92.0, 92.0, 151.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 145.0, 145.0, 146.0, 145.0, 144.0, 146.0, 145.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 58.0, 59.0, 57.0, 57.0, 77.0, 58.0, 56.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 58.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 73.0, 74.0, 74.0, 73.0, 74.0, 74.0, 73.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 127.0, 119.0, 121.0, 127.0, 117.0, 116.0, 118.0, 158.0, 125.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 161.0, 157.0, 158.0, 161.0, 167.0, 163.0, 165.0, 159.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 66.0, 65.0, 64.0, 67.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1524.5, "alertThreshold": 2.0}]} 03:36:08 INFO - Return code: 0 03:36:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:36:08 ERROR - # TBPL SUCCESS # 03:36:08 INFO - Running post-action listener: _resource_record_post_action 03:36:08 INFO - Running post-run listener: _resource_record_post_run 03:36:09 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 344064; Write bytes: 497995776; Read time: 120; Write time: 496516 03:36:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248254464; Read time: 0; Write time: 293164 03:36:09 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 344064; Write bytes: 248999936; Read time: 120; Write time: 203344 03:36:09 INFO - Running post-run listener: _upload_blobber_files 03:36:09 INFO - Blob upload gear active. 03:36:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:36:09 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:09 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:09 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:10 INFO - (blobuploader) - INFO - Open directory for files ... 03:36:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:36:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:36:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:11 INFO - (blobuploader) - INFO - Done attempting. 03:36:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:36:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:36:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:11 INFO - (blobuploader) - INFO - Done attempting. 03:36:11 INFO - (blobuploader) - INFO - Iteration through files over. 03:36:11 INFO - Return code: 0 03:36:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:36:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:36:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d76b62c8431e8e39f6d06dbf03c201f4fb25baee2796bb5d5cefe101c19bc465549414db5d609b2a9b98ffb72a4ba1fb289d8407245b3bf3538b5ec6ff0eb9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bb8c1abce41519d6a89ab0a6999806a17dcc1c730c8927d61c1616980067a403f5b73695644cd9b9a301d1bb7bd54677b17f07236747ccf56156ded4c22c704"} 03:36:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:36:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:36:11 INFO - Contents: 03:36:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d76b62c8431e8e39f6d06dbf03c201f4fb25baee2796bb5d5cefe101c19bc465549414db5d609b2a9b98ffb72a4ba1fb289d8407245b3bf3538b5ec6ff0eb9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bb8c1abce41519d6a89ab0a6999806a17dcc1c730c8927d61c1616980067a403f5b73695644cd9b9a301d1bb7bd54677b17f07236747ccf56156ded4c22c704"} 03:36:11 INFO - Running post-run listener: copy_logs_to_upload_dir 03:36:11 INFO - Copying logs to upload dir... 03:36:11 INFO - mkdir: /builds/slave/test/build/upload/logs 03:36:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.485126 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-06 03:36:11.688551) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 03:36:11.692186) ========= 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=fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349 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/0d76b62c8431e8e39f6d06dbf03c201f4fb25baee2796bb5d5cefe101c19bc465549414db5d609b2a9b98ffb72a4ba1fb289d8407245b3bf3538b5ec6ff0eb9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bb8c1abce41519d6a89ab0a6999806a17dcc1c730c8927d61c1616980067a403f5b73695644cd9b9a301d1bb7bd54677b17f07236747ccf56156ded4c22c704"} 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.011262 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/0d76b62c8431e8e39f6d06dbf03c201f4fb25baee2796bb5d5cefe101c19bc465549414db5d609b2a9b98ffb72a4ba1fb289d8407245b3bf3538b5ec6ff0eb9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bb8c1abce41519d6a89ab0a6999806a17dcc1c730c8927d61c1616980067a403f5b73695644cd9b9a301d1bb7bd54677b17f07236747ccf56156ded4c22c704"}' ========= master_lag: 0.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 03:36:11.771981) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:36:11.772328) ========= 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=fa44defc139c4ba8574fe040000001db-1462526297.302392-1515982349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.34 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:36:12.111909) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 03:36:12.112269) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 03:36:12.234234) ========= ========= Total master_lag: 0.67 =========