builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1462529814.86 results: success (0) buildid: 20160505123841 builduid: 1457772db7ef4c1982b4796b67a4914d revision: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 03:16:54.860346) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 03:16:54.860841) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 03:16:54.861127) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 03:16:54.877093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:16:54.877376) ========= 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=c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 03:16:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-05-06 03:16:55 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117022 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:16:55.007633) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:16:55.007944) ========= 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=c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014469 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:16:55.057416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:16:55.057783) ========= 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=c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 03:16:55,685 truncating revision to first 12 chars 2016-05-06 03:16:55,685 Setting DEBUG logging. 2016-05-06 03:16:55,685 attempt 1/10 2016-05-06 03:16:55,685 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:16:56,345 unpacking tar archive at: mozilla-aurora-0123e9f41ced/testing/mozharness/ program finished with exit code 0 elapsedTime=0.918972 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:16:55.989873) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 03:16:55.990258) ========= script_repo_revision: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 03:16:55.990686) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 03:16:55.990952) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 03:16:56.000802) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-06 03:16:56.001115) ========= /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=c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:16:56 INFO - MultiFileLogger online at 20160506 03:16:56 in /builds/slave/test 03:16:56 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:16:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:16:56 INFO - {'append_to_log': False, 03:16:56 INFO - 'base_work_dir': '/builds/slave/test', 03:16:56 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:16:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:16:56 INFO - 'branch': 'Mozilla-Aurora', 03:16:56 INFO - 'buildbot_json_path': 'buildprops.json', 03:16:56 INFO - 'config_files': ('talos/linux_config.py',), 03:16:56 INFO - 'default_actions': ('clobber', 03:16:56 INFO - 'read-buildbot-config', 03:16:56 INFO - 'download-and-extract', 03:16:56 INFO - 'populate-webroot', 03:16:56 INFO - 'create-virtualenv', 03:16:56 INFO - 'install', 03:16:56 INFO - 'run-tests'), 03:16:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:16:56 INFO - 'download_minidump_stackwalk': True, 03:16:56 INFO - 'download_symbols': 'ondemand', 03:16:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:16:56 INFO - 'tooltool.py': '/tools/tooltool.py', 03:16:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:16:56 INFO - '/tools/misc-python/virtualenv.py')}, 03:16:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:16:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:16:56 INFO - 'installer_path': 'installer.exe', 03:16:56 INFO - 'log_level': 'info', 03:16:56 INFO - 'log_name': 'talos', 03:16:56 INFO - 'log_to_console': True, 03:16:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:16:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:16:56 INFO - 'opt_config_files': (), 03:16:56 INFO - 'pip_index': False, 03:16:56 INFO - 'sps_profile': False, 03:16:56 INFO - 'sps_profile_interval': 0, 03:16:56 INFO - 'suite': 'dromaeojs', 03:16:56 INFO - 'system_bits': '32', 03:16:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:16:56 INFO - 'title': 'talos-linux64-ix-004', 03:16:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:16:56 INFO - 'use_talos_json': True, 03:16:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:16:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:16:56 INFO - 'work_dir': 'build'} 03:16:56 INFO - ##### 03:16:56 INFO - ##### Running clobber step. 03:16:56 INFO - ##### 03:16:56 INFO - Running pre-action listener: _resource_record_pre_action 03:16:56 INFO - Running main action method: clobber 03:16:56 INFO - rmtree: /builds/slave/test/build 03:16:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:16:57 INFO - Running post-action listener: _resource_record_post_action 03:16:57 INFO - ##### 03:16:57 INFO - ##### Running read-buildbot-config step. 03:16:57 INFO - ##### 03:16:57 INFO - Running pre-action listener: _resource_record_pre_action 03:16:57 INFO - Running main action method: read_buildbot_config 03:16:57 INFO - Using buildbot properties: 03:16:57 INFO - { 03:16:57 INFO - "project": "", 03:16:57 INFO - "product": "firefox", 03:16:57 INFO - "script_repo_revision": "production", 03:16:57 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:16:57 INFO - "repository": "", 03:16:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:16:57 INFO - "buildid": "20160505123841", 03:16:57 INFO - "pgo_build": "True", 03:16:57 INFO - "basedir": "/builds/slave/test", 03:16:57 INFO - "buildnumber": 304, 03:16:57 INFO - "slavename": "talos-linux64-ix-004", 03:16:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:16:57 INFO - "platform": "ubuntu64_hw", 03:16:57 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:16:57 INFO - "branch": "mozilla-aurora", 03:16:57 INFO - "repo_path": "releases/mozilla-aurora", 03:16:57 INFO - "revision": "0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b", 03:16:57 INFO - "stage_platform": "linux64-pgo", 03:16:57 INFO - "builduid": "1457772db7ef4c1982b4796b67a4914d", 03:16:57 INFO - "slavebuilddir": "test" 03:16:57 INFO - } 03:16:57 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:16:57 INFO - Running post-action listener: _resource_record_post_action 03:16:57 INFO - ##### 03:16:57 INFO - ##### Running download-and-extract step. 03:16:57 INFO - ##### 03:16:57 INFO - Running pre-action listener: _resource_record_pre_action 03:16:57 INFO - Running main action method: download_and_extract 03:16:57 INFO - mkdir: /builds/slave/test/build/tests 03:16: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:16:57 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:16:57 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:16:57 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:16:57 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:16:57 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:16:57 INFO - Downloaded 1361 bytes. 03:16:57 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:16:57 INFO - Using the following test package requirements: 03:16:57 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:16:57 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:16:57 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:16:57 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:57 INFO - u'jsshell-linux-x86_64.zip'], 03:16:57 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:16:57 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:16:57 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:16:57 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:16:57 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:16:57 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:57 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:16:57 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:16: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:16:57 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:16:57 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:16:57 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:16:57 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:16:57 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:16:59 INFO - Downloaded 23824026 bytes. 03:16:59 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:16:59 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:17:00 INFO - Return code: 0 03:17:00 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:17: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:17:00 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:17:00 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:17:00 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:17:00 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:17:00 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:17:01 INFO - Downloaded 23824026 bytes. 03:17:01 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:17:01 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:17:03 INFO - Return code: 0 03:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:03 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:17:03 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:17:03 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:17:03 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:17:03 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:17:04 INFO - Downloaded 10840145 bytes. 03:17:04 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:17:04 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:17:04 INFO - Return code: 0 03:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:04 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:17:04 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:17:04 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:17:04 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:17:04 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:17:05 INFO - Downloaded 62687148 bytes. 03:17:05 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:17:05 INFO - mkdir: /builds/slave/test/properties 03:17:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:17:05 INFO - Writing to file /builds/slave/test/properties/build_url 03:17:05 INFO - Contents: 03:17:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:17:06 INFO - Running post-action listener: _resource_record_post_action 03:17:06 INFO - Running post-action listener: set_extra_try_arguments 03:17:06 INFO - ##### 03:17:06 INFO - ##### Running populate-webroot step. 03:17:06 INFO - ##### 03:17:06 INFO - Running pre-action listener: _resource_record_pre_action 03:17:06 INFO - Running main action method: populate_webroot 03:17:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:17:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:17:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:17:06 INFO - '--tppagecycles', 03:17:06 INFO - '7'], 03:17:06 INFO - 'tests': ['tsvgm']}}, 03:17:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:17:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:17:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:17:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:17:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:17:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:17:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:06 INFO - 'talos_options': ['--disable-e10s'], 03:17:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:06 INFO - 'talos_options': ['--disable-e10s'], 03:17:06 INFO - 'tests': ['damp', 'tps']}, 03:17:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:06 INFO - 'tests': ['damp', 'tps']}, 03:17:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:17:06 INFO - 'tests': ['dromaeo_dom']}, 03:17:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:17:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:17:06 INFO - 'tests': ['a11yr', 03:17:06 INFO - 'ts_paint', 03:17:06 INFO - 'tpaint', 03:17:06 INFO - 'sessionrestore', 03:17:06 INFO - 'sessionrestore_no_auto_restore', 03:17:06 INFO - 'tabpaint']}, 03:17:06 INFO - 'other-e10s': {'tests': ['a11yr', 03:17:06 INFO - 'ts_paint', 03:17:06 INFO - 'tpaint', 03:17:06 INFO - 'sessionrestore', 03:17:06 INFO - 'sessionrestore_no_auto_restore', 03:17:06 INFO - 'tabpaint']}, 03:17:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:17:06 INFO - 'ts_paint', 03:17:06 INFO - 'tpaint', 03:17:06 INFO - 'sessionrestore', 03:17:06 INFO - 'sessionrestore_no_auto_restore', 03:17:06 INFO - 'tabpaint']}, 03:17:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:17:06 INFO - 'ts_paint', 03:17:06 INFO - 'tpaint', 03:17:06 INFO - 'sessionrestore', 03:17:06 INFO - 'sessionrestore_no_auto_restore', 03:17:06 INFO - 'tabpaint']}, 03:17:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:17:06 INFO - 'tests': ['a11yr', 03:17:06 INFO - 'ts_paint', 03:17:06 INFO - 'tpaint', 03:17:06 INFO - 'sessionrestore', 03:17:06 INFO - 'sessionrestore_no_auto_restore', 03:17:06 INFO - 'tabpaint']}, 03:17:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:17:06 INFO - 'tests': ['a11yr', 03:17:06 INFO - 'ts_paint', 03:17:06 INFO - 'tpaint', 03:17:06 INFO - 'sessionrestore', 03:17:06 INFO - 'sessionrestore_no_auto_restore', 03:17:06 INFO - 'tabpaint']}, 03:17:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:17:06 INFO - 'tests': ['tsvgx', 03:17:06 INFO - 'tsvgr_opacity', 03:17:06 INFO - 'tart', 03:17:06 INFO - 'tscrollx', 03:17:06 INFO - 'cart']}, 03:17:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:17:06 INFO - 'tsvgr_opacity', 03:17:06 INFO - 'tart', 03:17:06 INFO - 'tscrollx', 03:17:06 INFO - 'cart']}, 03:17:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:06 INFO - 'talos_options': ['--disable-e10s'], 03:17:06 INFO - 'tests': ['tp5o']}, 03:17:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:06 INFO - 'tests': ['tp5o']}, 03:17:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:06 INFO - 'talos_options': ['--disable-e10s', 03:17:06 INFO - '--xperf_path', 03:17:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:06 INFO - 'tests': ['tp5n']}, 03:17:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:06 INFO - 'talos_options': ['--xperf_path', 03:17:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:06 INFO - 'tests': ['tp5n']}}, 03:17:06 INFO - 'talos.zip': {'path': '', 03:17:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:17:06 INFO - Running post-action listener: _resource_record_post_action 03:17:06 INFO - ##### 03:17:06 INFO - ##### Running create-virtualenv step. 03:17:06 INFO - ##### 03:17:06 INFO - Running pre-action listener: _resource_record_pre_action 03:17:06 INFO - Running main action method: create_virtualenv 03:17:06 INFO - Creating virtualenv /builds/slave/test/build/venv 03:17:06 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:17:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:17:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:17:06 INFO - Using real prefix '/usr' 03:17:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:17:07 INFO - Installing distribute.............................................................................................................................................................................................done. 03:17:09 INFO - Installing pip.................done. 03:17:09 INFO - Return code: 0 03:17:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:17: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:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17: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:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:09 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 0x7fb1d6393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a410>, '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 0x158b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158b7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', '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:17:09 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:17:09 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:17:09 INFO - Using env: {'DISPLAY': ':0', 03:17:09 INFO - 'HOME': '/home/cltbld', 03:17:09 INFO - 'LANG': 'en_US.UTF-8', 03:17:09 INFO - 'LANGUAGE': 'en_US:en', 03:17:09 INFO - 'LOGNAME': 'cltbld', 03:17:09 INFO - 'MAIL': '/var/mail/cltbld', 03:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:09 INFO - 'MOZ_NO_REMOTE': '1', 03:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:09 INFO - 'NO_EM_RESTART': '1', 03:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:09 INFO - 'PWD': '/builds/slave/test', 03:17:09 INFO - 'SHELL': '/bin/bash', 03:17:09 INFO - 'SHLVL': '1', 03:17:09 INFO - 'TERM': 'linux', 03:17:09 INFO - 'TMOUT': '86400', 03:17:09 INFO - 'USER': 'cltbld', 03:17:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', 03:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:09 INFO - '_': '/tools/buildbot/bin/python'} 03:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:09 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:17:09 INFO - Cleaning up... 03:17:09 INFO - Return code: 0 03:17:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:17: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:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17: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:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:09 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 0x7fb1d6393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a410>, '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 0x158b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158b7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', '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:17:09 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:17:09 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:17:09 INFO - Using env: {'DISPLAY': ':0', 03:17:09 INFO - 'HOME': '/home/cltbld', 03:17:09 INFO - 'LANG': 'en_US.UTF-8', 03:17:09 INFO - 'LANGUAGE': 'en_US:en', 03:17:09 INFO - 'LOGNAME': 'cltbld', 03:17:09 INFO - 'MAIL': '/var/mail/cltbld', 03:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:09 INFO - 'MOZ_NO_REMOTE': '1', 03:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:09 INFO - 'NO_EM_RESTART': '1', 03:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:09 INFO - 'PWD': '/builds/slave/test', 03:17:09 INFO - 'SHELL': '/bin/bash', 03:17:09 INFO - 'SHLVL': '1', 03:17:09 INFO - 'TERM': 'linux', 03:17:09 INFO - 'TMOUT': '86400', 03:17:09 INFO - 'USER': 'cltbld', 03:17:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', 03:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:09 INFO - '_': '/tools/buildbot/bin/python'} 03:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:09 INFO - Downloading/unpacking psutil>=0.7.1 03:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:17:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:11 INFO - Installing collected packages: psutil 03:17:11 INFO - Running setup.py install for psutil 03:17:11 INFO - building 'psutil._psutil_linux' extension 03:17:11 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:17:11 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:17:11 INFO - building 'psutil._psutil_posix' extension 03:17:11 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:17:11 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:17:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:11 INFO - Successfully installed psutil 03:17:11 INFO - Cleaning up... 03:17:12 INFO - Return code: 0 03:17:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:17:12 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:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:12 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:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:12 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 0x7fb1d6393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a410>, '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 0x158b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158b7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', '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:17:12 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:17:12 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:17:12 INFO - Using env: {'DISPLAY': ':0', 03:17:12 INFO - 'HOME': '/home/cltbld', 03:17:12 INFO - 'LANG': 'en_US.UTF-8', 03:17:12 INFO - 'LANGUAGE': 'en_US:en', 03:17:12 INFO - 'LOGNAME': 'cltbld', 03:17:12 INFO - 'MAIL': '/var/mail/cltbld', 03:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:12 INFO - 'MOZ_NO_REMOTE': '1', 03:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:12 INFO - 'NO_EM_RESTART': '1', 03:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:12 INFO - 'PWD': '/builds/slave/test', 03:17:12 INFO - 'SHELL': '/bin/bash', 03:17:12 INFO - 'SHLVL': '1', 03:17:12 INFO - 'TERM': 'linux', 03:17:12 INFO - 'TMOUT': '86400', 03:17:12 INFO - 'USER': 'cltbld', 03:17:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', 03:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:12 INFO - '_': '/tools/buildbot/bin/python'} 03:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:17:14 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:17:14 INFO - Installing collected packages: mozsystemmonitor 03:17:14 INFO - Running setup.py install for mozsystemmonitor 03:17:14 INFO - Successfully installed mozsystemmonitor 03:17:14 INFO - Cleaning up... 03:17:14 INFO - Return code: 0 03:17:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb1d6393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a410>, '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 0x158b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158b7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', '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:17:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:17:14 INFO - Using env: {'DISPLAY': ':0', 03:17:14 INFO - 'HOME': '/home/cltbld', 03:17:14 INFO - 'LANG': 'en_US.UTF-8', 03:17:14 INFO - 'LANGUAGE': 'en_US:en', 03:17:14 INFO - 'LOGNAME': 'cltbld', 03:17:14 INFO - 'MAIL': '/var/mail/cltbld', 03:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:14 INFO - 'MOZ_NO_REMOTE': '1', 03:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:14 INFO - 'NO_EM_RESTART': '1', 03:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:14 INFO - 'PWD': '/builds/slave/test', 03:17:14 INFO - 'SHELL': '/bin/bash', 03:17:14 INFO - 'SHLVL': '1', 03:17:14 INFO - 'TERM': 'linux', 03:17:14 INFO - 'TMOUT': '86400', 03:17:14 INFO - 'USER': 'cltbld', 03:17:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', 03:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:14 INFO - '_': '/tools/buildbot/bin/python'} 03:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:14 INFO - Downloading/unpacking blobuploader==1.2.4 03:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:16 INFO - Downloading blobuploader-1.2.4.tar.gz 03:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:17:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:17: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:17: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:17: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:17: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:17: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:17: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:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:17:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:17: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:17: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:17: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:17: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:17: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:17: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:17:17 INFO - Downloading docopt-0.6.1.tar.gz 03:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:17:17 INFO - Installing collected packages: blobuploader, requests, docopt 03:17:17 INFO - Running setup.py install for blobuploader 03:17:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:17:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:17:17 INFO - Running setup.py install for requests 03:17:17 INFO - Running setup.py install for docopt 03:17:17 INFO - Successfully installed blobuploader requests docopt 03:17:17 INFO - Cleaning up... 03:17:17 INFO - Return code: 0 03:17:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:17 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:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:17 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:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:17 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 0x7fb1d6393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a410>, '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 0x158b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158b7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', '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:17:17 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:17:17 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:17:17 INFO - Using env: {'DISPLAY': ':0', 03:17:17 INFO - 'HOME': '/home/cltbld', 03:17:17 INFO - 'LANG': 'en_US.UTF-8', 03:17:17 INFO - 'LANGUAGE': 'en_US:en', 03:17:17 INFO - 'LOGNAME': 'cltbld', 03:17:17 INFO - 'MAIL': '/var/mail/cltbld', 03:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:17 INFO - 'MOZ_NO_REMOTE': '1', 03:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:17 INFO - 'NO_EM_RESTART': '1', 03:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:17 INFO - 'PWD': '/builds/slave/test', 03:17:17 INFO - 'SHELL': '/bin/bash', 03:17:17 INFO - 'SHLVL': '1', 03:17:17 INFO - 'TERM': 'linux', 03:17:17 INFO - 'TMOUT': '86400', 03:17:17 INFO - 'USER': 'cltbld', 03:17:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', 03:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:17 INFO - '_': '/tools/buildbot/bin/python'} 03:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:17 INFO - Running setup.py (path:/tmp/pip-iISE0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:18 INFO - Running setup.py (path:/tmp/pip-TZJdXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:18 INFO - Running setup.py (path:/tmp/pip-sqcPgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:18 INFO - Running setup.py (path:/tmp/pip-QHGzL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:18 INFO - Running setup.py (path:/tmp/pip-Cigbkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:18 INFO - Running setup.py (path:/tmp/pip-D5QkcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:18 INFO - Running setup.py (path:/tmp/pip-TlKu9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:18 INFO - Running setup.py (path:/tmp/pip-RrjU0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:18 INFO - Running setup.py (path:/tmp/pip-V2ZMjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:18 INFO - Running setup.py (path:/tmp/pip-oMx9f6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:18 INFO - Running setup.py (path:/tmp/pip-FXnZUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:18 INFO - Running setup.py (path:/tmp/pip-Ro0IZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:18 INFO - Running setup.py (path:/tmp/pip-6w1pqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:18 INFO - Running setup.py (path:/tmp/pip-KdIOJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:18 INFO - Running setup.py (path:/tmp/pip-VLc1y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:19 INFO - Running setup.py (path:/tmp/pip-6WFelC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:19 INFO - Running setup.py (path:/tmp/pip-s2BwKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:17:19 INFO - Running setup.py install for manifestparser 03:17:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:17:19 INFO - Running setup.py install for mozcrash 03:17:19 INFO - Running setup.py install for mozdebug 03:17:19 INFO - Running setup.py install for mozdevice 03:17:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:17:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:17:19 INFO - Running setup.py install for mozfile 03:17:19 INFO - Running setup.py install for mozhttpd 03:17:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:17:19 INFO - Running setup.py install for mozinfo 03:17:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:17:19 INFO - Running setup.py install for mozInstall 03:17:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:17:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:17:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:17:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:17:19 INFO - Running setup.py install for mozleak 03:17:20 INFO - Running setup.py install for mozlog 03:17:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:17:20 INFO - Running setup.py install for moznetwork 03:17:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:17:20 INFO - Running setup.py install for mozprocess 03:17:20 INFO - Running setup.py install for mozprofile 03:17:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:17:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:17:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:17:20 INFO - Running setup.py install for mozrunner 03:17:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:17:20 INFO - Running setup.py install for mozscreenshot 03:17:20 INFO - Running setup.py install for moztest 03:17:20 INFO - Running setup.py install for mozversion 03:17:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:17:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:17:20 INFO - Cleaning up... 03:17:20 INFO - Return code: 0 03:17:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:20 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:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:20 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:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:20 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 0x7fb1d6393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a410>, '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 0x158b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158b7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', '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:17:20 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:17:20 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:17:20 INFO - Using env: {'DISPLAY': ':0', 03:17:20 INFO - 'HOME': '/home/cltbld', 03:17:20 INFO - 'LANG': 'en_US.UTF-8', 03:17:20 INFO - 'LANGUAGE': 'en_US:en', 03:17:20 INFO - 'LOGNAME': 'cltbld', 03:17:20 INFO - 'MAIL': '/var/mail/cltbld', 03:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:20 INFO - 'MOZ_NO_REMOTE': '1', 03:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:20 INFO - 'NO_EM_RESTART': '1', 03:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:20 INFO - 'PWD': '/builds/slave/test', 03:17:20 INFO - 'SHELL': '/bin/bash', 03:17:20 INFO - 'SHLVL': '1', 03:17:20 INFO - 'TERM': 'linux', 03:17:20 INFO - 'TMOUT': '86400', 03:17:20 INFO - 'USER': 'cltbld', 03:17:20 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', 03:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:20 INFO - '_': '/tools/buildbot/bin/python'} 03:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:21 INFO - Running setup.py (path:/tmp/pip-RhgC3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:21 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:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:21 INFO - Running setup.py (path:/tmp/pip-Pdsuu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:21 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:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:21 INFO - Running setup.py (path:/tmp/pip-1ZMXTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:21 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:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:21 INFO - Running setup.py (path:/tmp/pip-cMOqY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:21 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:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:21 INFO - Running setup.py (path:/tmp/pip-sz5ag0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:21 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:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:21 INFO - Running setup.py (path:/tmp/pip-0iCoFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:21 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:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:21 INFO - Running setup.py (path:/tmp/pip-FnvAjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:21 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:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:21 INFO - Running setup.py (path:/tmp/pip-lavJDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:21 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:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:21 INFO - Running setup.py (path:/tmp/pip-YRVcG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:21 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:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:21 INFO - Running setup.py (path:/tmp/pip-IttU7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:21 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:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:21 INFO - Running setup.py (path:/tmp/pip-guimOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:21 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:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:21 INFO - Running setup.py (path:/tmp/pip-y_9gvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:22 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:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:22 INFO - Running setup.py (path:/tmp/pip-XR6DjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:22 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:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:22 INFO - Running setup.py (path:/tmp/pip-jlLujT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:22 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:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:22 INFO - Running setup.py (path:/tmp/pip-Dk7GhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:22 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:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:22 INFO - Running setup.py (path:/tmp/pip-PFreOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:22 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:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:22 INFO - Running setup.py (path:/tmp/pip-xKo9Tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:22 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:17:22 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:17:22 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:17:22 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:17:22 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:17:22 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:17:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:17:22 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:17:22 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:17:22 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:17:22 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:17:22 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:17:22 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:17:24 INFO - Downloading blessings-1.6.tar.gz 03:17:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:17:24 INFO - Installing collected packages: blessings 03:17:24 INFO - Running setup.py install for blessings 03:17:24 INFO - Successfully installed blessings 03:17:24 INFO - Cleaning up... 03:17:24 INFO - Return code: 0 03:17:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:17:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:24 INFO - Reading from file tmpfile_stdout 03:17:24 INFO - Current package versions: 03:17:24 INFO - argparse == 1.2.1 03:17:24 INFO - blessings == 1.6 03:17:24 INFO - blobuploader == 1.2.4 03:17:24 INFO - docopt == 0.6.1 03:17:24 INFO - manifestparser == 1.1 03:17:24 INFO - mozInstall == 1.12 03:17:24 INFO - mozcrash == 0.17 03:17:24 INFO - mozdebug == 0.1 03:17:24 INFO - mozdevice == 0.48 03:17:24 INFO - mozfile == 1.2 03:17:24 INFO - mozhttpd == 0.7 03:17:24 INFO - mozinfo == 0.9 03:17:24 INFO - mozleak == 0.1 03:17:24 INFO - mozlog == 3.1 03:17:24 INFO - moznetwork == 0.27 03:17:24 INFO - mozprocess == 0.22 03:17:24 INFO - mozprofile == 0.28 03:17:24 INFO - mozrunner == 6.11 03:17:24 INFO - mozscreenshot == 0.1 03:17:24 INFO - mozsystemmonitor == 0.0 03:17:24 INFO - moztest == 0.7 03:17:24 INFO - mozversion == 1.4 03:17:24 INFO - psutil == 3.1.1 03:17:24 INFO - requests == 1.2.3 03:17:24 INFO - wsgiref == 0.1.2 03:17:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:24 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:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:24 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:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:24 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 0x7fb1d6393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a410>, '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 0x158b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158b7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', '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:17:24 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:17:24 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:17:24 INFO - Using env: {'DISPLAY': ':0', 03:17:24 INFO - 'HOME': '/home/cltbld', 03:17:24 INFO - 'LANG': 'en_US.UTF-8', 03:17:24 INFO - 'LANGUAGE': 'en_US:en', 03:17:24 INFO - 'LOGNAME': 'cltbld', 03:17:24 INFO - 'MAIL': '/var/mail/cltbld', 03:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:24 INFO - 'MOZ_NO_REMOTE': '1', 03:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:24 INFO - 'NO_EM_RESTART': '1', 03:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:24 INFO - 'PWD': '/builds/slave/test', 03:17:24 INFO - 'SHELL': '/bin/bash', 03:17:24 INFO - 'SHLVL': '1', 03:17:24 INFO - 'TERM': 'linux', 03:17:24 INFO - 'TMOUT': '86400', 03:17:24 INFO - 'USER': 'cltbld', 03:17:24 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', 03:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:24 INFO - '_': '/tools/buildbot/bin/python'} 03:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:17:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:17:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:17:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:17:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:17:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:17:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:17:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:17:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:17:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:17:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:17:25 INFO - Cleaning up... 03:17:25 INFO - Return code: 0 03:17:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:25 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 0x7fb1d6393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a410>, '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 0x158b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158b7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', '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:17:25 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:17:25 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:17:25 INFO - Using env: {'DISPLAY': ':0', 03:17:25 INFO - 'HOME': '/home/cltbld', 03:17:25 INFO - 'LANG': 'en_US.UTF-8', 03:17:25 INFO - 'LANGUAGE': 'en_US:en', 03:17:25 INFO - 'LOGNAME': 'cltbld', 03:17:25 INFO - 'MAIL': '/var/mail/cltbld', 03:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:25 INFO - 'MOZ_NO_REMOTE': '1', 03:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:25 INFO - 'NO_EM_RESTART': '1', 03:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:25 INFO - 'PWD': '/builds/slave/test', 03:17:25 INFO - 'SHELL': '/bin/bash', 03:17:25 INFO - 'SHLVL': '1', 03:17:25 INFO - 'TERM': 'linux', 03:17:25 INFO - 'TMOUT': '86400', 03:17:25 INFO - 'USER': 'cltbld', 03:17:25 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', 03:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:25 INFO - '_': '/tools/buildbot/bin/python'} 03:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:25 INFO - Downloading/unpacking jsonschema 03:17:25 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:17:25 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:17:25 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:17:25 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:17:25 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:17:25 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:17:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:17:27 INFO - Downloading/unpacking functools32 (from jsonschema) 03:17:27 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:17:27 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:17:27 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:17:27 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:17:27 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:17:27 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:17:27 INFO - Downloading functools32-3.2.3-2.tar.gz 03:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:17:27 INFO - warning: no files found matching '*.txt' 03:17:27 INFO - no previously-included directories found matching 'build' 03:17:27 INFO - no previously-included directories found matching 'dist' 03:17:27 INFO - no previously-included directories found matching '.git*' 03:17:27 INFO - Installing collected packages: jsonschema, functools32 03:17:27 INFO - Running setup.py install for functools32 03:17:27 INFO - warning: no files found matching '*.txt' 03:17:27 INFO - no previously-included directories found matching 'build' 03:17:27 INFO - no previously-included directories found matching 'dist' 03:17:27 INFO - no previously-included directories found matching '.git*' 03:17:27 INFO - Successfully installed jsonschema functools32 03:17:27 INFO - Cleaning up... 03:17:27 INFO - Return code: 0 03:17:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:17:27 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:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:27 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:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:27 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 0x7fb1d6393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a410>, '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 0x158b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158b7a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', '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:17:27 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:17:27 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:17:27 INFO - Using env: {'DISPLAY': ':0', 03:17:27 INFO - 'HOME': '/home/cltbld', 03:17:27 INFO - 'LANG': 'en_US.UTF-8', 03:17:27 INFO - 'LANGUAGE': 'en_US:en', 03:17:27 INFO - 'LOGNAME': 'cltbld', 03:17:27 INFO - 'MAIL': '/var/mail/cltbld', 03:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:27 INFO - 'MOZ_NO_REMOTE': '1', 03:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:27 INFO - 'NO_EM_RESTART': '1', 03:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:27 INFO - 'PWD': '/builds/slave/test', 03:17:27 INFO - 'SHELL': '/bin/bash', 03:17:27 INFO - 'SHLVL': '1', 03:17:27 INFO - 'TERM': 'linux', 03:17:27 INFO - 'TMOUT': '86400', 03:17:27 INFO - 'USER': 'cltbld', 03:17:27 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', 03:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:27 INFO - '_': '/tools/buildbot/bin/python'} 03:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:27 INFO - Downloading/unpacking flake8 03:17:27 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:17:27 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:17:27 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:17:27 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:17:27 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:17:27 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:17:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:17:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:17:29 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:17:29 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:17:29 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:17:29 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:17:29 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:17:29 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:17:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:17:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:17:29 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:17:29 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:17:29 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:17:29 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:17:29 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:17:29 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:17:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:17:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:17:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:17:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:17:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:17:30 INFO - no previously-included directories found matching 'docs/_build' 03:17:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:17:30 INFO - Running setup.py install for pep8 03:17:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:17:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:17:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:17:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:17:30 INFO - no previously-included directories found matching 'docs/_build' 03:17:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:17:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:17:30 INFO - Cleaning up... 03:17:30 INFO - Return code: 0 03:17:30 INFO - Running post-action listener: _resource_record_post_action 03:17:30 INFO - Running post-action listener: _start_resource_monitoring 03:17:30 INFO - Starting resource monitoring. 03:17:30 INFO - ##### 03:17:30 INFO - ##### Running install step. 03:17:30 INFO - ##### 03:17:30 INFO - Running pre-action listener: _resource_record_pre_action 03:17:30 INFO - Running main action method: install 03:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:30 INFO - Reading from file tmpfile_stdout 03:17:30 INFO - Detecting whether we're running mozinstall >=1.0... 03:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:17:30 INFO - Reading from file tmpfile_stdout 03:17:30 INFO - Output received: 03:17:30 INFO - Usage: mozinstall [options] installer 03:17:30 INFO - Options: 03:17:30 INFO - -h, --help show this help message and exit 03:17:30 INFO - -d DEST, --destination=DEST 03:17:30 INFO - Directory to install application into. [default: 03:17:30 INFO - "/builds/slave/test"] 03:17:30 INFO - --app=APP Application being installed. [default: firefox] 03:17:30 INFO - mkdir: /builds/slave/test/build/application 03:17:30 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:17:30 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:17:46 INFO - Reading from file tmpfile_stdout 03:17:46 INFO - Output received: 03:17:46 INFO - /builds/slave/test/build/application/firefox/firefox 03:17:46 INFO - Running post-action listener: _resource_record_post_action 03:17:46 INFO - ##### 03:17:46 INFO - ##### Running run-tests step. 03:17:46 INFO - ##### 03:17:46 INFO - Running pre-action listener: _resource_record_pre_action 03:17:46 INFO - Running main action method: run_tests 03:17:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:17:46 INFO - Python 2.7.3 03:17:46 INFO - Return code: 0 03:17:46 INFO - grabbing minidump binary from tooltool 03:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:46 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 0x158a410>, '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 0x158b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158b7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:17:46 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:17:46 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:17:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:17:46 INFO - Return code: 0 03:17:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:17:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:17:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:17:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:17:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:17:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:17:47 INFO - Return code: 0 03:17:47 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-004', '--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:17:47 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-004 --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:17:47 INFO - Using env: {'DISPLAY': ':0', 03:17:47 INFO - 'HOME': '/home/cltbld', 03:17:47 INFO - 'LANG': 'en_US.UTF-8', 03:17:47 INFO - 'LANGUAGE': 'en_US:en', 03:17:47 INFO - 'LOGNAME': 'cltbld', 03:17:47 INFO - 'MAIL': '/var/mail/cltbld', 03:17:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:17:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:47 INFO - 'MOZ_NO_REMOTE': '1', 03:17:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:47 INFO - 'NO_EM_RESTART': '1', 03:17:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:47 INFO - 'PWD': '/builds/slave/test', 03:17:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:17:47 INFO - 'SHELL': '/bin/bash', 03:17:47 INFO - 'SHLVL': '1', 03:17:47 INFO - 'TERM': 'linux', 03:17:47 INFO - 'TMOUT': '86400', 03:17:47 INFO - 'USER': 'cltbld', 03:17:47 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981', 03:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:47 INFO - '_': '/tools/buildbot/bin/python'} 03:17:47 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-004', '--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:17:47 INFO - mozversion application_buildid: 20160505123841 03:17:47 INFO - mozversion application_changeset: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b 03:17:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:17:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:17:47 INFO - mozversion application_name: Firefox 03:17:47 INFO - mozversion application_remotingname: firefox-dev 03:17:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:17:47 INFO - mozversion application_vendor: Mozilla 03:17:47 INFO - mozversion application_version: 48.0a2 03:17:47 INFO - mozversion platform_buildid: 20160505123841 03:17:47 INFO - mozversion platform_changeset: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b 03:17:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:17:47 INFO - mozversion platform_version: 48.0a2 03:17:47 INFO - using testdate: 1462529867 03:17:47 INFO - actual date: 1462529867 03:17:47 INFO - starting webserver on 'localhost:46149' 03:17:47 INFO - SUITE-START | Running 2 tests 03:17:47 INFO - TEST-START | dromaeo_css 03:17:47 INFO - operating with platform_type : linux_ 03:17:47 INFO - Initialising browser for dromaeo_css test... 03:17:47 INFO - TEST-INFO | started process 22434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzLbLD6/profile http://localhost:46149/getInfo.html) 03:17:52 INFO - PROCESS | 22434 | __metrics Screen width/height:1600/1200 03:17:52 INFO - PROCESS | 22434 | colorDepth:24 03:17:52 INFO - PROCESS | 22434 | Browser inner width/height: 1024/697 03:17:52 INFO - PROCESS | 22434 | __metrics 03:17:53 ERROR - PROCESS | 22434 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:17:53 INFO - PROCESS | 22434 | console.error: PushService: 03:17:53 INFO - PROCESS | 22434 | stateChangeProcessEnqueue: Error transitioning state 03:17:53 INFO - PROCESS | 22434 | UnknownError 03:17:54 INFO - TEST-INFO | 22434: exit 0 03:17:54 INFO - Browser initialized. 03:17:54 INFO - Running cycle 1/1 for dromaeo_css test... 03:17:54 INFO - TEST-INFO | started process 22522 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzLbLD6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:18:05 INFO - PROCESS | 22522 | RSS: Main: 142258176 03:18:05 INFO - PROCESS | 22522 | 03:18:56 INFO - PROCESS | 22522 | 1462529936890 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:21:04 INFO - PROCESS | 22522 | Cycle 1(1): loaded http://localhost:46149/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46149/tests/dromaeo/cssquery-ext.html) 03:21:05 INFO - PROCESS | 22522 | RSS: Main: 251465728 03:21:05 INFO - PROCESS | 22522 | 03:24:07 INFO - PROCESS | 22522 | Cycle 1(1): loaded http://localhost:46149/tests/dromaeo/cssquery-ext.html (next: http://localhost:46149/tests/dromaeo/cssquery-jquery.html) 03:24:08 INFO - PROCESS | 22522 | RSS: Main: 226148352 03:24:08 INFO - PROCESS | 22522 | 03:27:10 INFO - PROCESS | 22522 | Cycle 1(1): loaded http://localhost:46149/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46149/tests/dromaeo/cssquery-mootools.html) 03:27:10 INFO - PROCESS | 22522 | RSS: Main: 223252480 03:27:10 INFO - PROCESS | 22522 | 03:30:12 INFO - PROCESS | 22522 | Cycle 1(1): loaded http://localhost:46149/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46149/tests/dromaeo/cssquery-prototype.html) 03:30:13 INFO - PROCESS | 22522 | RSS: Main: 216641536 03:30:13 INFO - PROCESS | 22522 | 03:33:15 INFO - PROCESS | 22522 | Cycle 1(1): loaded http://localhost:46149/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46149/tests/dromaeo/cssquery-yui.html) 03:33:16 INFO - PROCESS | 22522 | RSS: Main: 214052864 03:33:16 INFO - PROCESS | 22522 | 03:36:18 INFO - PROCESS | 22522 | Cycle 1(1): loaded http://localhost:46149/tests/dromaeo/cssquery-yui.html (next: http://localhost:46149/tests/dromaeo/cssquery-dojo.html) 03:36:18 INFO - PROCESS | 22522 | RSS: Main: 259637248 03:36:18 INFO - PROCESS | 22522 | 03:36:18 INFO - PROCESS | 22522 | __start_tp_report 03:36:18 INFO - PROCESS | 22522 | _x_x_mozilla_page_load 03:36:18 INFO - PROCESS | 22522 | _x_x_mozilla_page_load_details 03:36:18 INFO - PROCESS | 22522 | |i|pagename|runs| 03:36:18 INFO - PROCESS | 22522 | |0;dojo.html;3318.9336213275733;3356.7482438817096;3369.3766653169164;3375.2236985493337;3407.7273818094563;5439.5104440600335;5456.454354564542;5462.672239665618;5481.369642491115;5500.724963751806;5470.507654311111;5501.532369748566;5506.91739623906;5509.504144626982;5512.228288039668;4877.292792545079;4980.77586508608;5008.440630899699;5091.745412729368;5091.84724458265;4935.925961110586;5012.147934851084;5013.172826483626;5015.448300686921;5016.874578135539;5021.071101846152;5073.213651883964;5124.590032797368;5140.871478213037;5142.871428214287;5087.440381558025;5094.898102037975;5111.131107711661;5115.846524604268;5151.948480515184;4898.926516102261;4952.33143525623;5013.573846223039;5027.824026159067;5034.622403319766;5399.676019438846;5400.8135200232055;5449.291592093042;5450.4549545045575;5468.2891224141;5852.941470585282;5856.4143585641095;5859.794907178229;5860.033094539396;5861.296644402656;5880.059190529495;5893.6463812171405;5903.321118071391;5947.078202878561;5958.433948774859;5556.944430555724;5581.246531718247;5606.103023516218;5607.355154157283;5612.074007788669;5815.680137592389;6079.452849243501;6100.420460056288;6101.786437474667;6103.572749907553;5712.2288491054005;5780.21967034445;5781.88436231273;5799.101139323411;5801.274840644919;5896.469317761422;5918.171455996164;5922.289325280994;5924.792632257937;5929.021711417654;5743.310802703619;5811.651300921958;5889.293284805851;5899.852503687443;5908.202392676933;5897.410258974069;5900.704964751745;5905.4685078343155;5911.0837820137085;5948.078047902582;4472.239719247736;4485.035717320791;4488.057507923372;4491.236489796743;4520.4801447833925;3978.3833505806647;3984.362501999666;3990.0423898264207;4038.8384464621085;4079.143379890197;5598.86002849932;5600.60795744294;5628.60599758013;5645.040343141676;5652.802151924745;5889.52883769306;5891.617044892068;5893.5579831512805;5935.940640593625;5951.851203719855;5346.331708536433;5535.833924982257;5571.832845014656;5671.092625179951;5682.204491371212;5008.273800298936;5062.392512898402;5064.848054558369;5068.873278168002;5070.442251352349;6085.421884920926;6106.511479081662;6108.908366374508;6109.725062372204;6111.022236442148;5493.368262649847;5623.634463759842;5686.45978632021;5823.7379317931645;5903.173555702119;6003.849903752441;6014.398560143951;6026.819195424145;6054.212952316171;6059.121427393092;5693.032184528557;5743.0811070228565;5743.253377061123;5744.540436764965;5750.424957504216;5818.185454036354;5849.824505264849;5856.619319744203;5864.9413505864395;5899.17411562373;5767.077267637158;5769.59612827098;5792.565557583114;5803;5804.042333015174;5559.52744016747;5742.28221472316;5752.9137062943255;5773.336066352255;5778.16216648592;5657.830265092054;5681.204631351697;5683.573731970201;5687;5711.371749107512;5765.4522820332;5789.797357092481;5796.072628379439;5796.478316951495;5797.188393624981;5616.1014237721765;5651.971740141273;5684.602077854511;5710.857228569319;5744.741486633028 03:36:18 INFO - PROCESS | 22522 | |1;ext.html;655.2464665634523;661.1735330836455;661.5865084322298;672.2336536348562;727.1238158019587;32600.510992335134;33205.667943320586;39623.00942476436;40581.59418405815;40589.188216235656;43326.35010474845;43841.561584384144;43929.12141757163;44014.11971760563;44014.339784903175;8851.867221991659;9034.954825225897;9079.500627465486;9093.727188184332;9097.772555686128;8722.08418116095;8853.867191992125;8877.556122193897;8882.067382924797;8883.422577532472;8896.288296936229;8970.551472426352;9141.95429022854;9166.724998250063;9170.174684278414;9056.954715226415;9115.635374585008;9125.817483650357;9128.908710912872;9132.40639358443;8947.955260223722;9090.27277817773;9095.31785116119;9096.044915283866;9101.590428430736;43583.128337433394;44060;44202;44493.332600011025;44552.10895782066;3861.7489863158803;3995.720299579031;4074.2869997750277;4166.229247589205;4692.671512994092;30990.84504577485;31587.36825263505;31750.364992700015;31772.682273177204;33238.16904577381;4601.907961840778;4646.094011667727;4650.069986002813;4651.372064771246;4737.715737055788;252956;255693;256815;257331;258011;36084;57711.13433298504;58528.41471585315;58632.7068364664;58750.70624646849;38308.425373619415;38635.806820966274;38741.806290968925;38815.223695526496;38850.22299553993;15673.60815979587;16054.197290135446;16070.276837542338;16072.276747546388;16072.517824465285;13921.443142274398;14020.439182432792;14036;14055.437782488585;14056;9491.145796878314;9634.421934683942;9659.32384733062;9697.175740062174;9770.755731106638;3608.9294541169697;3662.1760103976926;3688.170161713647;3723.356416943946;3754.4743735877;1081.3674000709516;1085.696005118568;1120.8409788213817;1131.9830202546968;1196.5094311332311;34703;34710.47934280988;34781.82609086989;34990.12524686852;35372.469412958824;1189.3696340939316;1206.390772659801;1209.056935590241;1243.5150291386367;1250.5748045664518;17897.910510447364;18195.909020454812;18288.17703203359;18350.724739128924;18512.44462666122;481295;485203;489079;494215;494948;61450;62120.68939655273;62325.37674623286;62752.68623656852;62828.68585657134;1381.247220264958;1496.5285934930462;1504.7893294938717;1569.058564861097;1624.9843847595253;31822.36355272928;33420.498692520116;34141.317173655894;34417.79537716168;34858.12854678653;49926.750366247936;57529.424705752404;59200.407995919486;59387.406125938185;59541;486285;488011;488548;490233;494092;36091;40660.39009414802;41173.79413102915;41233.1753364937;42337.364939525316;44966.10067798691;45319.7734011341;45601.77199113983;45962.31056534222;46392.30411543762;38300.80849595734;39011;39168;39260;39899.2020159601;37949.423362538604;38603.420948686355;39067.41398879076;42110;42157.57842421537;42464.36303455389;42612.786936065124;42689.35965960451;43480;43908.12183756371;36065.27869442544;36835.447468288534;37271.44092838556;37786;37810.243795124494;28599.14202573926;28662.713372866005;28709.712902870702;28952.276193094498;29089.41821163607 03:36:18 INFO - PROCESS | 22522 | |2;jquery.html;408.2691981353378;421.1534815021809;426.24129050290486;430.58018432028797;433.71374892570907;18420.26318947242;18596;18855.528611784714;18978.715319270188;19124.043797810107;18133.90933045333;18300.450986470394;19383.70924436131;19508.245067705062;19540.804591954075;5474.91787623187;5926.199963005004;5935.614185077978;5939.079442686369;5941.465268125868;5610.635308704942;5670.404607516213;5750.079987202049;5785.16115163301;5786.652800831943;5810.389909059551;5831.533477321826;5842.298924129111;5846;5856;5758.913616295759;5818.185454036438;5855.151003104547;5863.501602363783;5915;5232.8691782705355;5259.815906443256;5278.788848446057;5304.124819404832;5304.283921670563;19831.107600157884;22092.447688807908;22836;22978.425539361484;23157.88421057884;2445.5475736988715;2456.9262922112366;2476.9009239630395;2525.393905462694;2576.1369941069765;9574.281928855295;9818.165455936254;9826.606935722562;10010.699679009642;10178.033086856736;2014.9697754533547;2061.793820617941;2068.6276470235352;2090.1848279171136;2117.915283388663;83987;86300.13699862984;86601;87817.56091219503;89176.554117229;11250.774984500264;11332.943335283271;11345.886541134649;11370.715732106599;11437.885621143849;15986.520404387888;16125.516234512983;16125.596860078593;16202;16216.837831621533;8568;8782.473051616924;8795.560221988875;8883.422577532569;8932.642694292155;8501.107383724744;8589;8605.655773769104;8671.653133874574;8743.475391476404;4796.208625576741;4874.268859671078;4939.604831613462;4964;5020.071286811952;1957.499426611227;1958.6866101423705;1979.0599465254177;2064.8038436348525;2096.15105882118;989.9653512127041;1099.982516172537;1140.823172408278;1143.525436943659;1151.585429245471;18514.537136571693;18914;19435.805641943683;19445.902770486056;19828.90085549563;1057.413135709673;1062.6758838554315;1090.8963648453384;1102.3771569063454;1108.3737688206138;10462.790744185073;10561.63034293796;10763.623273185402;10889.237753357347;10977.3962432067;528637;528730;548156;554062;554246;96985;97590;99667.50166249268;100153.49923250337;100482.49758751159;1066.2482949520725;1076.6260395827182;1117.608836907076;1139.9145064120223;1152.792497350485;16386;16767.664646707242;16784.40548147924;17203.483895483154;17382.826171738627;39401;39509.20981580295;41153.0527125512;41289.79355103325;41580;55511.44488555063;56800;57839;57975.420245797;59527;8392.4544904581;8490.872636910328;8519.787005324917;8633.56832158377;8750.781230469289;9278.443293402148;13617.319134043457;13742.450301988209;13919.791203132163;14057.086289391566;11052.834207486734;11771.411429428323;11997.340146292037;12185.390730463265;12297.56958506448;11726.589569365031;11988.280703157838;12058.276503409823;12378.566750163702;12431.191972521758;10964.506597203304;11793.29240245588;11884.823787559673;12152.57465988686;12467;8568.657253709782;8613.48319100856;8721.258693011165;8878.422902511316;8896;8760.299176065771;11805.350705711267;12450.564230251897;12617.684557886127;12755.298458584866 03:36:18 INFO - PROCESS | 22522 | |3;mootools.html;1442.4590778458078;1581.9367225310984;1612.3872928287249;1825.543614096476;1920.8463322934167;7667.4249431292665;8450.154984501547;8662.783430414243;8680.826383472335;8703.52130632815;8317;8453.57732113395;8516;8530.744077677664;8549.91450085499;2096.5492419129882;2315.606346921023;2317.860928344296;2362.2558893948435;2375.6199008158696;2415.6014257647466;2429.4047958250253;2433.5741245282093;2434.184548176363;2440.487497625501;2298.850574712647;2333.36999010268;2333.9299821005397;2335.74306826249;2336.976630233693;2078.6362386582364;2294.5869743446174;2358.5872472317274;2359.7640235976437;2361.220797136958;2275.0785931697687;2280.703508543895;2282.201229569654;2285.165914441234;2326.732425771041;8315.584220788936;8414.621342039623;8568.528730919797;8660.30717542595;8664.826703465895;5139.794408223666;5271.499207575274;5275.868103297448;5304.098303288451;5314.1497360422145;3216.2602601401572;3240.7731458797657;3356;3365.175531994677;3372.1738174147245;1040.152275895143;1043.207162556455;1061.5806756331283;1093.294824837983;1098.2477003252798;11701.999999999915;11754.764904701944;11784.880436358531;11795.705107372298;11810.704732381673;4550.977245113753;4613.238815595456;4669.95330046702;4676.789544470507;4691.249400095969;10152.492375381202;10158.339707918962;10168.389896606228;10169.593216271267;10184.694459166238;4798.04039192156;5293.788248470095;5324.946750532523;5325;5327.493888080626;4775.976120119447;4896.167651499253;4915.754212289443;4919.950800492021;4920.286558449005;4019.653416105579;4024.01895292066;4102.671786257092;4110.630043296118;4115.855945041909;1235.7466719322517;1300.8894243989178;1304.1392680830795;1306.4578200046874;1317.4598414649947;874.5889431966965;909.3543584055395;930.4603330068544;986.958758509779;1027.6403258859489;5792.420757924174;5821.068629019336;5833.79581714638;5894.587378883522;5973.731182096816;446.11891514259725;447.54350562426794;457.78941686824436;457.82602611007604;467.18243074619414;3827.9043023924623;3835;3837.712171587142;3870.6909881733914;3903.082775547744;10141.340812847142;10612.522436490377;10646.840297395545;10705.304155229886;10748.408837513856;10419.94790026045;10550.103241224582;10573.629922952814;10577.841332379867;10590.788184236271;7796.688132474637;8147.67409303633;8229.588520573947;8244.711435099744;8255.752327430067;5816.5055970243;5833.737481813244;5886.20536227621;5971.850703732442;6000.279966404059;9401.576929038347;9501.57242924084;9831.901680983385;9843.064908833649;9918.206543476648;9702.175315098013;9927.851082233918;9933.15568176713;10043.849342259726;10094.697159085239;7607.88588171189;7806.102298235775;7814.413918956215;7836.451448398558;7881.566513841564;8319.916800832156;8331.458455200393;8384.53885036329;8387.454815436977;8409.369297302605;7632.313091821763;7806.297433231037;7834.099078606033;7865.646045927832;7920.643571039433;7692.538447693157;7693.615319234128;7711;7767.766966990999;7871.645775939982;7150.213476517475;7209.963950180216;7224.566526008456;7233.276672332935;7251.093613298338;5230.084735171406;5292.153255479105;5298;5364.168553874156;5410.918836217381;5209.635325527177;5216.191490319006;5341.332333458317;5399.541039011571;5406.162044883049 03:36:18 INFO - PROCESS | 22522 | |4;prototype.html;330.74202122344565;332.90806155808946;338.2085918949657;343.3099470065169;344.2735827404177;5296.682199068054;5382.946170538294;5396.8111116110995;5421.620486565942;5460;5336.971950658744;5349.8127565535215;5361.865953351168;5373.274607927929;5374.811881584145;4031.093004074089;4093.3655283431117;4250.61744443;4260.656638848636;4272.209641216369;4228.851990180345;4239.47006624172;4245.490541135068;4247.702660813744;4260.957390426087;3996.8601098961544;4183.853565125221;4188.832446702128;4195.5175154857125;4235.449391579091;4096.487939007624;4194.475690538683;4204.8528301509305;4206.390073439365;4208.810603522848;3710.870119545803;3711.888643340704;3720;3722.8510859565586;3732.9440058399146;5170.224466330043;5177.585793136578;5178.9444227905715;5194.6883187008525;5200.6619569727845;4478.193925093482;4731.929021064687;4748.406449193851;4752.382190315271;4764.666473346867;5608.775648974036;5618.690971996539;5624.690642014688;5639.069553523705;5649.435056494318;3995.720299579031;4016.518017837849;4018.799060046986;4037.2934736421007;4059.7564146151326;5643.774249030034;5795.797147099831;5847.502962248172;5870.295564532284;5889.440503152194;4047.615476529725;4069.084455997436;4075.694322925792;4083.2650122977557;4092.1815636872743;4123.36087906375;4133.173365326947;4145.0880806222585;4161;4178.979105104455;4579.427571553556;4721.740304283228;4728.54115859751;4753.691010084333;4784.373313073502;5665.801696940587;5669.177969194444;5692.6299790513485;5704.629199102128;5711.286089238845;1487.5537338798317;1491.3818506920113;1497;1504.8645621894082;1505.9247037648074;936;940.1444685336311;1002.0060080439872;1002.6139936124645;1011.4234886114843;5728.226689396878;5827.184194212814;5828.417158284137;5832.650040997553;5851.765929362778;6114.877702446015;6119.44924956756;6144.463884028993;6147.600405973598;6154.876902461926;5652.547796176296;5834.24154859874;5850.61970971894;5850.970745146247;5853.678047707332;3241.173500757292;3253.430649636304;3261.1357990132633;3261.967380326214;3268.5587445694528;5770.480656740913;6099.96950015256;6124.755009799647;6300.369963003663;6429.9678501607195;5930.873134104507;5950.85122871923;5984.3417224105315;5988.490978266809;5993.670348130895;5761.193432919478;6117.602355846856;6129.908051379233;6140.754369825247;6173.660448675366;5850.912236316373;5882.352941176553;5915.645061296336;5927;5928.851778705394;5813.76744930198;5833.562482813721;5835.241418615553;5839.912401314069;5855.677937713466;5940.198073260228;6137.754489820357;6142.78500252489;6160.7535698571555;6175.3824617539685;4093.8771836844944;4126.690498212586;4129.669626429938;4151.8546850861285;4153.0447996960265;5850.414958504116;5916.31962324321;5925.585209035326;5930.555208359477;5938.168656388023;5728.598998070262;5741.5406767459335;5783.190353350618;5784.2191304175085;5784.334801497714;5676.290463692038;5690.800821971211;5724.313082430135;5724.74238659253;5762;5356.12592540786;5404.270423492778;5593.860153496195;5614.494695477427;5677.687727175045;5718.742656580381;5720.456556627114;5733.8566535836935;5734.426557344399;5762.337331206965;5438.211459338453;5589.5248903842;5621.831345059655;5626.662400255997;5648.604597678287 03:36:18 INFO - PROCESS | 22522 | |5;yui.html;858.6222062292587;908.196246322005;911.4258017449006;920.5375620215923;932.2262522106648;14378.568642940701;14628.561143165722;14690.63273418165;14716;14736.557903262907;14518.056326338781;14522;14544.781828272584;14568.417263309455;14614.415423383052;762.211111499598;888.0852721696663;913.1462082952444;925.9166674999249;926.536731634183;904.4934836491553;912.6486302773413;916.8533034714447;918.0773322810566;922.8615707643874;958.4776296918161;970.9950201541407;973.1047436358567;974.7027156717198;974.7075877236836;791.7901756034627;943.0804965158984;966.4829316315772;967.8741763570725;968.1335204991564;705.2172088981226;709.2588245283691;709.8402859356655;711.950163488556;715.2597062040815;14793.852061479463;14794.63013424673;14848.109113453227;14854.034487758261;14937.327820248114;14412.711745765131;14872.62818429537;14875.776863347059;14967;15144.772828407582;10671.893281067167;10920.672379828618;10940.671779846618;11172.441377931153;11408.486618102206;3738.1962877981364;3783.641082093462;3809.923801523954;3820.178661587772;3829.2341531693774;56417;57727.71136144335;58335.416645833844;58910.70544647292;59038.70480647569;11491.253068550517;11611.76776464466;11623.07015438763;11674;11765.529378824922;18506;18980.715289270673;20358.491037723878;20647.690284645443;20683.82819803929;7684.423668224906;7698.384129269645;7701.730439434593;7822.335101516434;7866.881996770053;4619.260918253063;4637.118947399983;4662.813487460531;4856.805727770849;4883.316335713003;3371.679690429405;3499.107727529464;3500.43992961125;3501.124718820295;3504.9660350196755;585.956897407889;634.3244444666416;645.6803882078401;653.2422390027546;654.2410803467955;658.295623682655;709.3048812164108;754.5698951597647;761.7638532055081;773.5397438524069;9553.856692149484;9797.80404391908;9798.608055677692;9871.457069861226;9907.504624768733;800.3237264511479;804.6120442237094;814.8952491009273;845.9534725590029;850.5364576305928;4429.269170586882;4510.977445112753;4543.363929049936;4593.517680643551;4695.671303008825;66086.66956665186;67068.32931670621;67193.32806671968;67477;68351.3164868355;57452;57821;59097.40902590919;59194;59534.40465595289;52192;52706.20940685893;53155.73422132942;53294.46705532895;53897.730511347196;8826.470411775314;8946.776330591787;8954.865677014719;9076.273898088006;9101.817963640558;33674.158146046546;34030.82984585061;34820.129496762784;35045.12387190341;35556.466652999705;46717.53282467132;47304.7634761824;47469.287960679925;47817.28274075822;48199;11530.82703759461;11555.653330400102;11790.646280611596;11891.82162267584;11981.580644677395;12848.103776578775;12967.740645186856;13151.868481315065;13307.66730831737;13400.396982135633;12581;13017.153884997444;13152.342382880626;13253.13854599448;13283.185487093315;12551.05867059956;12699.238045717286;12739.490420383081;12789.488420463078;13148.079634425498;11999.700007499883;12366.134370593973;12507.374631268218;13136.737265254833;13180.275084870424;10451.94774026125;10453;10556.736081598021;10567.735806604896;10775.137988961022;10366.585336586451;10504.789904202025;10653.89346106529;10734.355938643706;10808.675739727822 03:36:18 INFO - PROCESS | 22522 | __end_tp_report 03:36:18 INFO - PROCESS | 22522 | __start_cc_report 03:36:18 INFO - PROCESS | 22522 | _x_x_mozilla_cycle_collect,872 03:36:18 INFO - PROCESS | 22522 | __end_cc_report 03:36:18 INFO - PROCESS | 22522 | __startTimestamp1462530978952__endTimestamp 03:36:18 INFO - PROCESS | 22522 | 03:36:18 INFO - PROCESS | 22522 | ------- Summary: start ------- 03:36:18 INFO - PROCESS | 22522 | Number of tests: 6 03:36:18 INFO - PROCESS | 22522 | 03:36:18 INFO - PROCESS | 22522 | [#0] dojo.html Cycles:165 Average:5472.60 Median:5683.57 stddev:594.72 (10.5%) stddev-sans-first:572.04 03:36:18 INFO - PROCESS | 22522 | Values: 3318.9 3356.7 3369.4 3375.2 3407.7 5439.5 5456.5 5462.7 5481.4 5500.7 5470.5 5501.5 5506.9 5509.5 5512.2 4877.3 4980.8 5008.4 5091.7 5091.8 4935.9 5012.1 5013.2 5015.4 5016.9 5021.1 5073.2 5124.6 5140.9 5142.9 5087.4 5094.9 5111.1 5115.8 5151.9 4898.9 4952.3 5013.6 5027.8 5034.6 5399.7 5400.8 5449.3 5450.5 5468.3 5852.9 5856.4 5859.8 5860.0 5861.3 5880.1 5893.6 5903.3 5947.1 5958.4 5556.9 5581.2 5606.1 5607.4 5612.1 5815.7 6079.5 6100.4 6101.8 6103.6 5712.2 5780.2 5781.9 5799.1 5801.3 5896.5 5918.2 5922.3 5924.8 5929.0 5743.3 5811.7 5889.3 5899.9 5908.2 5897.4 5900.7 5905.5 5911.1 5948.1 4472.2 4485.0 4488.1 4491.2 4520.5 3978.4 3984.4 3990.0 4038.8 4079.1 5598.9 5600.6 5628.6 5645.0 5652.8 5889.5 5891.6 5893.6 5935.9 5951.9 5346.3 5535.8 5571.8 5671.1 5682.2 5008.3 5062.4 5064.8 5068.9 5070.4 6085.4 6106.5 6108.9 6109.7 6111.0 5493.4 5623.6 5686.5 5823.7 5903.2 6003.8 6014.4 6026.8 6054.2 6059.1 5693.0 5743.1 5743.3 5744.5 5750.4 5818.2 5849.8 5856.6 5864.9 5899.2 5767.1 5769.6 5792.6 5803.0 5804.0 5559.5 5742.3 5752.9 5773.3 5778.2 5657.8 5681.2 5683.6 5687.0 5711.4 5765.5 5789.8 5796.1 5796.5 5797.2 5616.1 5652.0 5684.6 5710.9 5744.7 03:36:18 INFO - PROCESS | 22522 | 03:36:18 INFO - PROCESS | 22522 | [#1] ext.html Cycles:180 Average:57402.99 Median:22699.70 stddev:113131.38 (498.4%) stddev-sans-first:113368.51 03:36:18 INFO - PROCESS | 22522 | Values: 655.2 661.2 661.6 672.2 727.1 32600.5 33205.7 39623.0 40581.6 40589.2 43326.4 43841.6 43929.1 44014.1 44014.3 8851.9 9035.0 9079.5 9093.7 9097.8 8722.1 8853.9 8877.6 8882.1 8883.4 8896.3 8970.6 9142.0 9166.7 9170.2 9057.0 9115.6 9125.8 9128.9 9132.4 8948.0 9090.3 9095.3 9096.0 9101.6 43583.1 44060.0 44202.0 44493.3 44552.1 3861.7 3995.7 4074.3 4166.2 4692.7 30990.8 31587.4 31750.4 31772.7 33238.2 4601.9 4646.1 4650.1 4651.4 4737.7 252956.0 255693.0 256815.0 257331.0 258011.0 36084.0 57711.1 58528.4 58632.7 58750.7 38308.4 38635.8 38741.8 38815.2 38850.2 15673.6 16054.2 16070.3 16072.3 16072.5 13921.4 14020.4 14036.0 14055.4 14056.0 9491.1 9634.4 9659.3 9697.2 9770.8 3608.9 3662.2 3688.2 3723.4 3754.5 1081.4 1085.7 1120.8 1132.0 1196.5 34703.0 34710.5 34781.8 34990.1 35372.5 1189.4 1206.4 1209.1 1243.5 1250.6 17897.9 18195.9 18288.2 18350.7 18512.4 481295.0 485203.0 489079.0 494215.0 494948.0 61450.0 62120.7 62325.4 62752.7 62828.7 1381.2 1496.5 1504.8 1569.1 1625.0 31822.4 33420.5 34141.3 34417.8 34858.1 49926.8 57529.4 59200.4 59387.4 59541.0 486285.0 488011.0 488548.0 490233.0 494092.0 36091.0 40660.4 41173.8 41233.2 42337.4 44966.1 45319.8 45601.8 45962.3 46392.3 38300.8 39011.0 39168.0 39260.0 39899.2 37949.4 38603.4 39067.4 42110.0 42157.6 42464.4 42612.8 42689.4 43480.0 43908.1 36065.3 36835.4 37271.4 37786.0 37810.2 28599.1 28662.7 28709.7 28952.3 29089.4 03:36:18 INFO - PROCESS | 22522 | 03:36:18 INFO - PROCESS | 22522 | [#2] jquery.html Cycles:180 Average:30824.61 Median:12801.72 stddev:89462.48 (698.8%) stddev-sans-first:89684.29 03:36:18 INFO - PROCESS | 22522 | Values: 408.3 421.2 426.2 430.6 433.7 18420.3 18596.0 18855.5 18978.7 19124.0 18133.9 18300.5 19383.7 19508.2 19540.8 5474.9 5926.2 5935.6 5939.1 5941.5 5610.6 5670.4 5750.1 5785.2 5786.7 5810.4 5831.5 5842.3 5846.0 5856.0 5758.9 5818.2 5855.2 5863.5 5915.0 5232.9 5259.8 5278.8 5304.1 5304.3 19831.1 22092.4 22836.0 22978.4 23157.9 2445.5 2456.9 2476.9 2525.4 2576.1 9574.3 9818.2 9826.6 10010.7 10178.0 2015.0 2061.8 2068.6 2090.2 2117.9 83987.0 86300.1 86601.0 87817.6 89176.6 11250.8 11332.9 11345.9 11370.7 11437.9 15986.5 16125.5 16125.6 16202.0 16216.8 8568.0 8782.5 8795.6 8883.4 8932.6 8501.1 8589.0 8605.7 8671.7 8743.5 4796.2 4874.3 4939.6 4964.0 5020.1 1957.5 1958.7 1979.1 2064.8 2096.2 990.0 1100.0 1140.8 1143.5 1151.6 18514.5 18914.0 19435.8 19445.9 19828.9 1057.4 1062.7 1090.9 1102.4 1108.4 10462.8 10561.6 10763.6 10889.2 10977.4 528637.0 528730.0 548156.0 554062.0 554246.0 96985.0 97590.0 99667.5 100153.5 100482.5 1066.2 1076.6 1117.6 1139.9 1152.8 16386.0 16767.7 16784.4 17203.5 17382.8 39401.0 39509.2 41153.1 41289.8 41580.0 55511.4 56800.0 57839.0 57975.4 59527.0 8392.5 8490.9 8519.8 8633.6 8750.8 9278.4 13617.3 13742.5 13919.8 14057.1 11052.8 11771.4 11997.3 12185.4 12297.6 11726.6 11988.3 12058.3 12378.6 12431.2 10964.5 11793.3 11884.8 12152.6 12467.0 8568.7 8613.5 8721.3 8878.4 8896.0 8760.3 11805.4 12450.6 12617.7 12755.3 03:36:18 INFO - PROCESS | 22522 | 03:36:18 INFO - PROCESS | 22522 | [#3] mootools.html Cycles:180 Average:5719.27 Median:4905.96 stddev:3207.61 (65.4%) stddev-sans-first:3200.50 03:36:18 INFO - PROCESS | 22522 | Values: 1442.5 1581.9 1612.4 1825.5 1920.8 7667.4 8450.2 8662.8 8680.8 8703.5 8317.0 8453.6 8516.0 8530.7 8549.9 2096.5 2315.6 2317.9 2362.3 2375.6 2415.6 2429.4 2433.6 2434.2 2440.5 2298.9 2333.4 2333.9 2335.7 2337.0 2078.6 2294.6 2358.6 2359.8 2361.2 2275.1 2280.7 2282.2 2285.2 2326.7 8315.6 8414.6 8568.5 8660.3 8664.8 5139.8 5271.5 5275.9 5304.1 5314.1 3216.3 3240.8 3356.0 3365.2 3372.2 1040.2 1043.2 1061.6 1093.3 1098.2 11702.0 11754.8 11784.9 11795.7 11810.7 4551.0 4613.2 4670.0 4676.8 4691.2 10152.5 10158.3 10168.4 10169.6 10184.7 4798.0 5293.8 5324.9 5325.0 5327.5 4776.0 4896.2 4915.8 4920.0 4920.3 4019.7 4024.0 4102.7 4110.6 4115.9 1235.7 1300.9 1304.1 1306.5 1317.5 874.6 909.4 930.5 987.0 1027.6 5792.4 5821.1 5833.8 5894.6 5973.7 446.1 447.5 457.8 457.8 467.2 3827.9 3835.0 3837.7 3870.7 3903.1 10141.3 10612.5 10646.8 10705.3 10748.4 10419.9 10550.1 10573.6 10577.8 10590.8 7796.7 8147.7 8229.6 8244.7 8255.8 5816.5 5833.7 5886.2 5971.9 6000.3 9401.6 9501.6 9831.9 9843.1 9918.2 9702.2 9927.9 9933.2 10043.8 10094.7 7607.9 7806.1 7814.4 7836.5 7881.6 8319.9 8331.5 8384.5 8387.5 8409.4 7632.3 7806.3 7834.1 7865.6 7920.6 7692.5 7693.6 7711.0 7767.8 7871.6 7150.2 7210.0 7224.6 7233.3 7251.1 5230.1 5292.2 5298.0 5364.2 5410.9 5209.6 5216.2 5341.3 5399.5 5406.2 03:36:18 INFO - PROCESS | 22522 | 03:36:18 INFO - PROCESS | 22522 | [#4] prototype.html Cycles:180 Average:4817.61 Median:5524.76 stddev:1433.49 (25.9%) stddev-sans-first:1397.39 03:36:18 INFO - PROCESS | 22522 | Values: 330.7 332.9 338.2 343.3 344.3 5296.7 5382.9 5396.8 5421.6 5460.0 5337.0 5349.8 5361.9 5373.3 5374.8 4031.1 4093.4 4250.6 4260.7 4272.2 4228.9 4239.5 4245.5 4247.7 4261.0 3996.9 4183.9 4188.8 4195.5 4235.4 4096.5 4194.5 4204.9 4206.4 4208.8 3710.9 3711.9 3720.0 3722.9 3732.9 5170.2 5177.6 5178.9 5194.7 5200.7 4478.2 4731.9 4748.4 4752.4 4764.7 5608.8 5618.7 5624.7 5639.1 5649.4 3995.7 4016.5 4018.8 4037.3 4059.8 5643.8 5795.8 5847.5 5870.3 5889.4 4047.6 4069.1 4075.7 4083.3 4092.2 4123.4 4133.2 4145.1 4161.0 4179.0 4579.4 4721.7 4728.5 4753.7 4784.4 5665.8 5669.2 5692.6 5704.6 5711.3 1487.6 1491.4 1497.0 1504.9 1505.9 936.0 940.1 1002.0 1002.6 1011.4 5728.2 5827.2 5828.4 5832.7 5851.8 6114.9 6119.4 6144.5 6147.6 6154.9 5652.5 5834.2 5850.6 5851.0 5853.7 3241.2 3253.4 3261.1 3262.0 3268.6 5770.5 6100.0 6124.8 6300.4 6430.0 5930.9 5950.9 5984.3 5988.5 5993.7 5761.2 6117.6 6129.9 6140.8 6173.7 5850.9 5882.4 5915.6 5927.0 5928.9 5813.8 5833.6 5835.2 5839.9 5855.7 5940.2 6137.8 6142.8 6160.8 6175.4 4093.9 4126.7 4129.7 4151.9 4153.0 5850.4 5916.3 5925.6 5930.6 5938.2 5728.6 5741.5 5783.2 5784.2 5784.3 5676.3 5690.8 5724.3 5724.7 5762.0 5356.1 5404.3 5593.9 5614.5 5677.7 5718.7 5720.5 5733.9 5734.4 5762.3 5438.2 5589.5 5621.8 5626.7 5648.6 03:36:18 INFO - PROCESS | 22522 | 03:36:18 INFO - PROCESS | 22522 | [#5] yui.html Cycles:180 Average:15433.75 Median:4649.97 stddev:18222.69 (391.9%) stddev-sans-first:18240.94 03:36:18 INFO - PROCESS | 22522 | Values: 858.6 908.2 911.4 920.5 932.2 14378.6 14628.6 14690.6 14716.0 14736.6 14518.1 14522.0 14544.8 14568.4 14614.4 762.2 888.1 913.1 925.9 926.5 904.5 912.6 916.9 918.1 922.9 958.5 971.0 973.1 974.7 974.7 791.8 943.1 966.5 967.9 968.1 705.2 709.3 709.8 712.0 715.3 14793.9 14794.6 14848.1 14854.0 14937.3 14412.7 14872.6 14875.8 14967.0 15144.8 10671.9 10920.7 10940.7 11172.4 11408.5 3738.2 3783.6 3809.9 3820.2 3829.2 56417.0 57727.7 58335.4 58910.7 59038.7 11491.3 11611.8 11623.1 11674.0 11765.5 18506.0 18980.7 20358.5 20647.7 20683.8 7684.4 7698.4 7701.7 7822.3 7866.9 4619.3 4637.1 4662.8 4856.8 4883.3 3371.7 3499.1 3500.4 3501.1 3505.0 586.0 634.3 645.7 653.2 654.2 658.3 709.3 754.6 761.8 773.5 9553.9 9797.8 9798.6 9871.5 9907.5 800.3 804.6 814.9 846.0 850.5 4429.3 4511.0 4543.4 4593.5 4695.7 66086.7 67068.3 67193.3 67477.0 68351.3 57452.0 57821.0 59097.4 59194.0 59534.4 52192.0 52706.2 53155.7 53294.5 53897.7 8826.5 8946.8 8954.9 9076.3 9101.8 33674.2 34030.8 34820.1 35045.1 35556.5 46717.5 47304.8 47469.3 47817.3 48199.0 11530.8 11555.7 11790.6 11891.8 11981.6 12848.1 12967.7 13151.9 13307.7 13400.4 12581.0 13017.2 13152.3 13253.1 13283.2 12551.1 12699.2 12739.5 12789.5 13148.1 11999.7 12366.1 12507.4 13136.7 13180.3 10451.9 10453.0 10556.7 10567.7 10775.1 10366.6 10504.8 10653.9 10734.4 10808.7 03:36:18 INFO - PROCESS | 22522 | -------- Summary: end -------- 03:36:18 INFO - PROCESS | 22522 | 03:36:19 INFO - TEST-INFO | 22522: exit 0 03:36:19 INFO - TEST-OK | dromaeo_css | took 1111886ms 03:36:19 INFO - TEST-START | kraken 03:36:19 INFO - operating with platform_type : linux_ 03:36:19 INFO - Initialising browser for kraken test... 03:36:19 INFO - TEST-INFO | started process 22713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMowm4q/profile http://localhost:46149/getInfo.html) 03:36:23 INFO - PROCESS | 22713 | __metrics Screen width/height:1600/1200 03:36:23 INFO - PROCESS | 22713 | colorDepth:24 03:36:23 INFO - PROCESS | 22713 | Browser inner width/height: 1024/697 03:36:23 INFO - PROCESS | 22713 | __metrics 03:36:25 ERROR - PROCESS | 22713 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:36:25 INFO - TEST-INFO | 22713: exit 0 03:36:25 INFO - Browser initialized. 03:36:25 INFO - Running cycle 1/1 for kraken test... 03:36:25 INFO - TEST-INFO | started process 22804 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMowm4q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:37 INFO - PROCESS | 22804 | RSS: Main: 142647296 03:36:37 INFO - PROCESS | 22804 | 03:36:40 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:46149/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46149/tests/kraken/driver.html?testName=audio-beat-detection) 03:36:40 INFO - PROCESS | 22804 | RSS: Main: 190930944 03:36:40 INFO - PROCESS | 22804 | 03:36:43 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:46149/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46149/tests/kraken/driver.html?testName=audio-dft) 03:36:44 INFO - PROCESS | 22804 | RSS: Main: 185438208 03:36:44 INFO - PROCESS | 22804 | 03:36:47 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:46149/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46149/tests/kraken/driver.html?testName=audio-fft) 03:36:47 INFO - PROCESS | 22804 | RSS: Main: 273375232 03:36:47 INFO - PROCESS | 22804 | 03:36:49 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:46149/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46149/tests/kraken/driver.html?testName=audio-oscillator) 03:36:50 INFO - PROCESS | 22804 | RSS: Main: 182374400 03:36:50 INFO - PROCESS | 22804 | 03:36:52 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:46149/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46149/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:36:53 INFO - PROCESS | 22804 | RSS: Main: 180953088 03:36:53 INFO - PROCESS | 22804 | 03:36:56 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:46149/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46149/tests/kraken/driver.html?testName=imaging-darkroom) 03:36:56 INFO - PROCESS | 22804 | RSS: Main: 215318528 03:36:56 INFO - PROCESS | 22804 | 03:36:59 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:46149/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46149/tests/kraken/driver.html?testName=imaging-desaturate) 03:37:00 INFO - PROCESS | 22804 | RSS: Main: 216801280 03:37:00 INFO - PROCESS | 22804 | 03:37:03 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:46149/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46149/tests/kraken/driver.html?testName=json-parse-financial) 03:37:03 INFO - PROCESS | 22804 | RSS: Main: 216244224 03:37:03 INFO - PROCESS | 22804 | 03:37:05 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:46149/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46149/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:37:06 INFO - PROCESS | 22804 | RSS: Main: 196472832 03:37:06 INFO - PROCESS | 22804 | 03:37:07 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:46149/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46149/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:37:08 INFO - PROCESS | 22804 | RSS: Main: 199827456 03:37:08 INFO - PROCESS | 22804 | 03:37:10 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:46149/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46149/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:37:11 INFO - PROCESS | 22804 | RSS: Main: 208338944 03:37:11 INFO - PROCESS | 22804 | 03:37:13 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:46149/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:37:14 INFO - PROCESS | 22804 | RSS: Main: 215732224 03:37:14 INFO - PROCESS | 22804 | 03:37:16 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:46149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:37:17 INFO - PROCESS | 22804 | RSS: Main: 213676032 03:37:17 INFO - PROCESS | 22804 | 03:37:19 INFO - PROCESS | 22804 | Cycle 1(1): loaded http://localhost:46149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46149/tests/kraken/driver.html?testName=ai-astar) 03:37:19 INFO - PROCESS | 22804 | RSS: Main: 277495808 03:37:19 INFO - PROCESS | 22804 | 03:37:19 INFO - PROCESS | 22804 | __start_tp_report 03:37:19 INFO - PROCESS | 22804 | _x_x_mozilla_page_load 03:37:19 INFO - PROCESS | 22804 | _x_x_mozilla_page_load_details 03:37:19 INFO - PROCESS | 22804 | |i|pagename|runs| 03:37:19 INFO - PROCESS | 22804 | |0;ai-astar;110;112;106;110;111;110;100;109;110;111 03:37:19 INFO - PROCESS | 22804 | |1;audio-beat-detection;152;125;152;187;130;158;167;128;184;128 03:37:19 INFO - PROCESS | 22804 | |2;audio-dft;163;162;162;161;162;161;160;164;161;162 03:37:19 INFO - PROCESS | 22804 | |3;audio-fft;77;76;77;169;77;77;77;76;183;76 03:37:19 INFO - PROCESS | 22804 | |4;audio-oscillator;91;92;155;93;92;92;161;92;91;146 03:37:19 INFO - PROCESS | 22804 | |5;imaging-gaussian-blur;117;116;116;116;117;116;117;117;116;117 03:37:19 INFO - PROCESS | 22804 | |6;imaging-darkroom;146;145;147;146;145;146;146;145;145;144 03:37:19 INFO - PROCESS | 22804 | |7;imaging-desaturate;95;94;94;94;95;96;94;94;95;94 03:37:19 INFO - PROCESS | 22804 | |8;json-parse-financial;56;58;59;58;58;58;58;76;57;55 03:37:19 INFO - PROCESS | 22804 | |9;json-stringify-tinderbox;60;58;57;58;58;58;59;59;58;58 03:37:19 INFO - PROCESS | 22804 | |10;stanford-crypto-aes;75;72;73;74;82;75;74;75;74;81 03:37:19 INFO - PROCESS | 22804 | |11;stanford-crypto-ccm;120;119;116;121;119;119;124;127;157;124 03:37:19 INFO - PROCESS | 22804 | |12;stanford-crypto-pbkdf2;164;156;158;158;162;172;158;157;157;161 03:37:19 INFO - PROCESS | 22804 | |13;stanford-crypto-sha256-iterative;68;71;67;65;65;69;66;65;66;66 03:37:19 INFO - PROCESS | 22804 | __end_tp_report 03:37:19 INFO - PROCESS | 22804 | __start_cc_report 03:37:19 INFO - PROCESS | 22804 | _x_x_mozilla_cycle_collect,1632 03:37:19 INFO - PROCESS | 22804 | __end_cc_report 03:37:19 INFO - PROCESS | 22804 | __startTimestamp1462531039373__endTimestamp 03:37:19 INFO - PROCESS | 22804 | 03:37:19 INFO - PROCESS | 22804 | ------- Summary: start ------- 03:37:19 INFO - PROCESS | 22804 | Number of tests: 14 03:37:19 INFO - PROCESS | 22804 | 03:37:19 INFO - PROCESS | 22804 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:3.51 (3.2%) stddev-sans-first:3.70 03:37:19 INFO - PROCESS | 22804 | Values: 110.0 112.0 106.0 110.0 111.0 110.0 100.0 109.0 110.0 111.0 03:37:19 INFO - PROCESS | 22804 | 03:37:19 INFO - PROCESS | 22804 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:155.00 stddev:23.25 (15.0%) stddev-sans-first:24.66 03:37:19 INFO - PROCESS | 22804 | Values: 152.0 125.0 152.0 187.0 130.0 158.0 167.0 128.0 184.0 128.0 03:37:19 INFO - PROCESS | 22804 | 03:37:19 INFO - PROCESS | 22804 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 03:37:19 INFO - PROCESS | 22804 | Values: 163.0 162.0 162.0 161.0 162.0 161.0 160.0 164.0 161.0 162.0 03:37:19 INFO - PROCESS | 22804 | 03:37:19 INFO - PROCESS | 22804 | [#3] audio-fft Cycles:10 Average:96.50 Median:77.00 stddev:42.03 (54.6%) stddev-sans-first:43.99 03:37:19 INFO - PROCESS | 22804 | Values: 77.0 76.0 77.0 169.0 77.0 77.0 77.0 76.0 183.0 76.0 03:37:19 INFO - PROCESS | 22804 | 03:37:19 INFO - PROCESS | 22804 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:92.00 stddev:30.23 (32.9%) stddev-sans-first:31.23 03:37:19 INFO - PROCESS | 22804 | Values: 91.0 92.0 155.0 93.0 92.0 92.0 161.0 92.0 91.0 146.0 03:37:19 INFO - PROCESS | 22804 | 03:37:19 INFO - PROCESS | 22804 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:37:19 INFO - PROCESS | 22804 | Values: 117.0 116.0 116.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 03:37:19 INFO - PROCESS | 22804 | 03:37:19 INFO - PROCESS | 22804 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 03:37:19 INFO - PROCESS | 22804 | Values: 146.0 145.0 147.0 146.0 145.0 146.0 146.0 145.0 145.0 144.0 03:37:19 INFO - PROCESS | 22804 | 03:37:19 INFO - PROCESS | 22804 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 03:37:19 INFO - PROCESS | 22804 | Values: 95.0 94.0 94.0 94.0 95.0 96.0 94.0 94.0 95.0 94.0 03:37:19 INFO - PROCESS | 22804 | 03:37:19 INFO - PROCESS | 22804 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:58.00 stddev:5.98 (10.3%) stddev-sans-first:6.22 03:37:19 INFO - PROCESS | 22804 | Values: 56.0 58.0 59.0 58.0 58.0 58.0 58.0 76.0 57.0 55.0 03:37:19 INFO - PROCESS | 22804 | 03:37:19 INFO - PROCESS | 22804 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:0.82 (1.4%) stddev-sans-first:0.60 03:37:19 INFO - PROCESS | 22804 | Values: 60.0 58.0 57.0 58.0 58.0 58.0 59.0 59.0 58.0 58.0 03:37:19 INFO - PROCESS | 22804 | 03:37:19 INFO - PROCESS | 22804 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.00 stddev:3.31 (4.4%) stddev-sans-first:3.50 03:37:19 INFO - PROCESS | 22804 | Values: 75.0 72.0 73.0 74.0 82.0 75.0 74.0 75.0 74.0 81.0 03:37:19 INFO - PROCESS | 22804 | 03:37:19 INFO - PROCESS | 22804 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:122.50 stddev:11.82 (9.7%) stddev-sans-first:12.42 03:37:19 INFO - PROCESS | 22804 | Values: 120.0 119.0 116.0 121.0 119.0 119.0 124.0 127.0 157.0 124.0 03:37:19 INFO - PROCESS | 22804 | 03:37:19 INFO - PROCESS | 22804 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:159.50 stddev:4.83 (3.0%) stddev-sans-first:4.94 03:37:19 INFO - PROCESS | 22804 | Values: 164.0 156.0 158.0 158.0 162.0 172.0 158.0 157.0 157.0 161.0 03:37:19 INFO - PROCESS | 22804 | 03:37:19 INFO - PROCESS | 22804 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.50 stddev:1.99 (3.0%) stddev-sans-first:2.06 03:37:19 INFO - PROCESS | 22804 | Values: 68.0 71.0 67.0 65.0 65.0 69.0 66.0 65.0 66.0 66.0 03:37:19 INFO - PROCESS | 22804 | -------- Summary: end -------- 03:37:19 INFO - PROCESS | 22804 | 03:37:20 INFO - TEST-INFO | 22804: exit 0 03:37:20 INFO - TEST-OK | kraken | took 60606ms 03:37:20 INFO - SUITE-END | took 1172s 03:37:20 INFO - Completed test suite (00:19:32) 03:37:20 INFO - javascript benchmark 03:37:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3318.9336213275733, 3356.7482438817096, 3369.3766653169164, 3375.2236985493337, 3407.7273818094563, 5439.5104440600335, 5456.454354564542, 5462.672239665618, 5481.369642491115, 5500.724963751806, 5470.507654311111, 5501.532369748566, 5506.91739623906, 5509.504144626982, 5512.228288039668, 4877.292792545079, 4980.77586508608, 5008.440630899699, 5091.745412729368, 5091.84724458265, 4935.925961110586, 5012.147934851084, 5013.172826483626, 5015.448300686921, 5016.874578135539, 5021.071101846152, 5073.213651883964, 5124.590032797368, 5140.871478213037, 5142.871428214287, 5087.440381558025, 5094.898102037975, 5111.131107711661, 5115.846524604268, 5151.948480515184, 4898.926516102261, 4952.33143525623, 5013.573846223039, 5027.824026159067, 5034.622403319766, 5399.676019438846, 5400.8135200232055, 5449.291592093042, 5450.4549545045575, 5468.2891224141, 5852.941470585282, 5856.4143585641095, 5859.794907178229, 5860.033094539396, 5861.296644402656, 5880.059190529495, 5893.6463812171405, 5903.321118071391, 5947.078202878561, 5958.433948774859, 5556.944430555724, 5581.246531718247, 5606.103023516218, 5607.355154157283, 5612.074007788669, 5815.680137592389, 6079.452849243501, 6100.420460056288, 6101.786437474667, 6103.572749907553, 5712.2288491054005, 5780.21967034445, 5781.88436231273, 5799.101139323411, 5801.274840644919, 5896.469317761422, 5918.171455996164, 5922.289325280994, 5924.792632257937, 5929.021711417654, 5743.310802703619, 5811.651300921958, 5889.293284805851, 5899.852503687443, 5908.202392676933, 5897.410258974069, 5900.704964751745, 5905.4685078343155, 5911.0837820137085, 5948.078047902582, 4472.239719247736, 4485.035717320791, 4488.057507923372, 4491.236489796743, 4520.4801447833925, 3978.3833505806647, 3984.362501999666, 3990.0423898264207, 4038.8384464621085, 4079.143379890197, 5598.86002849932, 5600.60795744294, 5628.60599758013, 5645.040343141676, 5652.802151924745, 5889.52883769306, 5891.617044892068, 5893.5579831512805, 5935.940640593625, 5951.851203719855, 5346.331708536433, 5535.833924982257, 5571.832845014656, 5671.092625179951, 5682.204491371212, 5008.273800298936, 5062.392512898402, 5064.848054558369, 5068.873278168002, 5070.442251352349, 6085.421884920926, 6106.511479081662, 6108.908366374508, 6109.725062372204, 6111.022236442148, 5493.368262649847, 5623.634463759842, 5686.45978632021, 5823.7379317931645, 5903.173555702119, 6003.849903752441, 6014.398560143951, 6026.819195424145, 6054.212952316171, 6059.121427393092, 5693.032184528557, 5743.0811070228565, 5743.253377061123, 5744.540436764965, 5750.424957504216, 5818.185454036354, 5849.824505264849, 5856.619319744203, 5864.9413505864395, 5899.17411562373, 5767.077267637158, 5769.59612827098, 5792.565557583114, 5803.0, 5804.042333015174, 5559.52744016747, 5742.28221472316, 5752.9137062943255, 5773.336066352255, 5778.16216648592, 5657.830265092054, 5681.204631351697, 5683.573731970201, 5687.0, 5711.371749107512, 5765.4522820332, 5789.797357092481, 5796.072628379439, 5796.478316951495, 5797.188393624981, 5616.1014237721765, 5651.971740141273, 5684.602077854511, 5710.857228569319, 5744.741486633028], "value": 5434.925482218361, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.2464665634523, 661.1735330836455, 661.5865084322298, 672.2336536348562, 727.1238158019587, 32600.510992335134, 33205.667943320586, 39623.00942476436, 40581.59418405815, 40589.188216235656, 43326.35010474845, 43841.561584384144, 43929.12141757163, 44014.11971760563, 44014.339784903175, 8851.867221991659, 9034.954825225897, 9079.500627465486, 9093.727188184332, 9097.772555686128, 8722.08418116095, 8853.867191992125, 8877.556122193897, 8882.067382924797, 8883.422577532472, 8896.288296936229, 8970.551472426352, 9141.95429022854, 9166.724998250063, 9170.174684278414, 9056.954715226415, 9115.635374585008, 9125.817483650357, 9128.908710912872, 9132.40639358443, 8947.955260223722, 9090.27277817773, 9095.31785116119, 9096.044915283866, 9101.590428430736, 43583.128337433394, 44060.0, 44202.0, 44493.332600011025, 44552.10895782066, 3861.7489863158803, 3995.720299579031, 4074.2869997750277, 4166.229247589205, 4692.671512994092, 30990.84504577485, 31587.36825263505, 31750.364992700015, 31772.682273177204, 33238.16904577381, 4601.907961840778, 4646.094011667727, 4650.069986002813, 4651.372064771246, 4737.715737055788, 252956.0, 255693.0, 256815.0, 257331.0, 258011.0, 36084.0, 57711.13433298504, 58528.41471585315, 58632.7068364664, 58750.70624646849, 38308.425373619415, 38635.806820966274, 38741.806290968925, 38815.223695526496, 38850.22299553993, 15673.60815979587, 16054.197290135446, 16070.276837542338, 16072.276747546388, 16072.517824465285, 13921.443142274398, 14020.439182432792, 14036.0, 14055.437782488585, 14056.0, 9491.145796878314, 9634.421934683942, 9659.32384733062, 9697.175740062174, 9770.755731106638, 3608.9294541169697, 3662.1760103976926, 3688.170161713647, 3723.356416943946, 3754.4743735877, 1081.3674000709516, 1085.696005118568, 1120.8409788213817, 1131.9830202546968, 1196.5094311332311, 34703.0, 34710.47934280988, 34781.82609086989, 34990.12524686852, 35372.469412958824, 1189.3696340939316, 1206.390772659801, 1209.056935590241, 1243.5150291386367, 1250.5748045664518, 17897.910510447364, 18195.909020454812, 18288.17703203359, 18350.724739128924, 18512.44462666122, 481295.0, 485203.0, 489079.0, 494215.0, 494948.0, 61450.0, 62120.68939655273, 62325.37674623286, 62752.68623656852, 62828.68585657134, 1381.247220264958, 1496.5285934930462, 1504.7893294938717, 1569.058564861097, 1624.9843847595253, 31822.36355272928, 33420.498692520116, 34141.317173655894, 34417.79537716168, 34858.12854678653, 49926.750366247936, 57529.424705752404, 59200.407995919486, 59387.406125938185, 59541.0, 486285.0, 488011.0, 488548.0, 490233.0, 494092.0, 36091.0, 40660.39009414802, 41173.79413102915, 41233.1753364937, 42337.364939525316, 44966.10067798691, 45319.7734011341, 45601.77199113983, 45962.31056534222, 46392.30411543762, 38300.80849595734, 39011.0, 39168.0, 39260.0, 39899.2020159601, 37949.423362538604, 38603.420948686355, 39067.41398879076, 42110.0, 42157.57842421537, 42464.36303455389, 42612.786936065124, 42689.35965960451, 43480.0, 43908.12183756371, 36065.27869442544, 36835.447468288534, 37271.44092838556, 37786.0, 37810.243795124494, 28599.14202573926, 28662.713372866005, 28709.712902870702, 28952.276193094498, 29089.41821163607], "value": 19685.35140196118, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.2691981353378, 421.1534815021809, 426.24129050290486, 430.58018432028797, 433.71374892570907, 18420.26318947242, 18596.0, 18855.528611784714, 18978.715319270188, 19124.043797810107, 18133.90933045333, 18300.450986470394, 19383.70924436131, 19508.245067705062, 19540.804591954075, 5474.91787623187, 5926.199963005004, 5935.614185077978, 5939.079442686369, 5941.465268125868, 5610.635308704942, 5670.404607516213, 5750.079987202049, 5785.16115163301, 5786.652800831943, 5810.389909059551, 5831.533477321826, 5842.298924129111, 5846.0, 5856.0, 5758.913616295759, 5818.185454036438, 5855.151003104547, 5863.501602363783, 5915.0, 5232.8691782705355, 5259.815906443256, 5278.788848446057, 5304.124819404832, 5304.283921670563, 19831.107600157884, 22092.447688807908, 22836.0, 22978.425539361484, 23157.88421057884, 2445.5475736988715, 2456.9262922112366, 2476.9009239630395, 2525.393905462694, 2576.1369941069765, 9574.281928855295, 9818.165455936254, 9826.606935722562, 10010.699679009642, 10178.033086856736, 2014.9697754533547, 2061.793820617941, 2068.6276470235352, 2090.1848279171136, 2117.915283388663, 83987.0, 86300.13699862984, 86601.0, 87817.56091219503, 89176.554117229, 11250.774984500264, 11332.943335283271, 11345.886541134649, 11370.715732106599, 11437.885621143849, 15986.520404387888, 16125.516234512983, 16125.596860078593, 16202.0, 16216.837831621533, 8568.0, 8782.473051616924, 8795.560221988875, 8883.422577532569, 8932.642694292155, 8501.107383724744, 8589.0, 8605.655773769104, 8671.653133874574, 8743.475391476404, 4796.208625576741, 4874.268859671078, 4939.604831613462, 4964.0, 5020.071286811952, 1957.499426611227, 1958.6866101423705, 1979.0599465254177, 2064.8038436348525, 2096.15105882118, 989.9653512127041, 1099.982516172537, 1140.823172408278, 1143.525436943659, 1151.585429245471, 18514.537136571693, 18914.0, 19435.805641943683, 19445.902770486056, 19828.90085549563, 1057.413135709673, 1062.6758838554315, 1090.8963648453384, 1102.3771569063454, 1108.3737688206138, 10462.790744185073, 10561.63034293796, 10763.623273185402, 10889.237753357347, 10977.3962432067, 528637.0, 528730.0, 548156.0, 554062.0, 554246.0, 96985.0, 97590.0, 99667.50166249268, 100153.49923250337, 100482.49758751159, 1066.2482949520725, 1076.6260395827182, 1117.608836907076, 1139.9145064120223, 1152.792497350485, 16386.0, 16767.664646707242, 16784.40548147924, 17203.483895483154, 17382.826171738627, 39401.0, 39509.20981580295, 41153.0527125512, 41289.79355103325, 41580.0, 55511.44488555063, 56800.0, 57839.0, 57975.420245797, 59527.0, 8392.4544904581, 8490.872636910328, 8519.787005324917, 8633.56832158377, 8750.781230469289, 9278.443293402148, 13617.319134043457, 13742.450301988209, 13919.791203132163, 14057.086289391566, 11052.834207486734, 11771.411429428323, 11997.340146292037, 12185.390730463265, 12297.56958506448, 11726.589569365031, 11988.280703157838, 12058.276503409823, 12378.566750163702, 12431.191972521758, 10964.506597203304, 11793.29240245588, 11884.823787559673, 12152.57465988686, 12467.0, 8568.657253709782, 8613.48319100856, 8721.258693011165, 8878.422902511316, 8896.0, 8760.299176065771, 11805.350705711267, 12450.564230251897, 12617.684557886127, 12755.298458584866], "value": 9464.835128449004, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.4590778458078, 1581.9367225310984, 1612.3872928287249, 1825.543614096476, 1920.8463322934167, 7667.4249431292665, 8450.154984501547, 8662.783430414243, 8680.826383472335, 8703.52130632815, 8317.0, 8453.57732113395, 8516.0, 8530.744077677664, 8549.91450085499, 2096.5492419129882, 2315.606346921023, 2317.860928344296, 2362.2558893948435, 2375.6199008158696, 2415.6014257647466, 2429.4047958250253, 2433.5741245282093, 2434.184548176363, 2440.487497625501, 2298.850574712647, 2333.36999010268, 2333.9299821005397, 2335.74306826249, 2336.976630233693, 2078.6362386582364, 2294.5869743446174, 2358.5872472317274, 2359.7640235976437, 2361.220797136958, 2275.0785931697687, 2280.703508543895, 2282.201229569654, 2285.165914441234, 2326.732425771041, 8315.584220788936, 8414.621342039623, 8568.528730919797, 8660.30717542595, 8664.826703465895, 5139.794408223666, 5271.499207575274, 5275.868103297448, 5304.098303288451, 5314.1497360422145, 3216.2602601401572, 3240.7731458797657, 3356.0, 3365.175531994677, 3372.1738174147245, 1040.152275895143, 1043.207162556455, 1061.5806756331283, 1093.294824837983, 1098.2477003252798, 11701.999999999915, 11754.764904701944, 11784.880436358531, 11795.705107372298, 11810.704732381673, 4550.977245113753, 4613.238815595456, 4669.95330046702, 4676.789544470507, 4691.249400095969, 10152.492375381202, 10158.339707918962, 10168.389896606228, 10169.593216271267, 10184.694459166238, 4798.04039192156, 5293.788248470095, 5324.946750532523, 5325.0, 5327.493888080626, 4775.976120119447, 4896.167651499253, 4915.754212289443, 4919.950800492021, 4920.286558449005, 4019.653416105579, 4024.01895292066, 4102.671786257092, 4110.630043296118, 4115.855945041909, 1235.7466719322517, 1300.8894243989178, 1304.1392680830795, 1306.4578200046874, 1317.4598414649947, 874.5889431966965, 909.3543584055395, 930.4603330068544, 986.958758509779, 1027.6403258859489, 5792.420757924174, 5821.068629019336, 5833.79581714638, 5894.587378883522, 5973.731182096816, 446.11891514259725, 447.54350562426794, 457.78941686824436, 457.82602611007604, 467.18243074619414, 3827.9043023924623, 3835.0, 3837.712171587142, 3870.6909881733914, 3903.082775547744, 10141.340812847142, 10612.522436490377, 10646.840297395545, 10705.304155229886, 10748.408837513856, 10419.94790026045, 10550.103241224582, 10573.629922952814, 10577.841332379867, 10590.788184236271, 7796.688132474637, 8147.67409303633, 8229.588520573947, 8244.711435099744, 8255.752327430067, 5816.5055970243, 5833.737481813244, 5886.20536227621, 5971.850703732442, 6000.279966404059, 9401.576929038347, 9501.57242924084, 9831.901680983385, 9843.064908833649, 9918.206543476648, 9702.175315098013, 9927.851082233918, 9933.15568176713, 10043.849342259726, 10094.697159085239, 7607.88588171189, 7806.102298235775, 7814.413918956215, 7836.451448398558, 7881.566513841564, 8319.916800832156, 8331.458455200393, 8384.53885036329, 8387.454815436977, 8409.369297302605, 7632.313091821763, 7806.297433231037, 7834.099078606033, 7865.646045927832, 7920.643571039433, 7692.538447693157, 7693.615319234128, 7711.0, 7767.766966990999, 7871.645775939982, 7150.213476517475, 7209.963950180216, 7224.566526008456, 7233.276672332935, 7251.093613298338, 5230.084735171406, 5292.153255479105, 5298.0, 5364.168553874156, 5410.918836217381, 5209.635325527177, 5216.191490319006, 5341.332333458317, 5399.541039011571, 5406.162044883049], "value": 4521.841447563292, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.74202122344565, 332.90806155808946, 338.2085918949657, 343.3099470065169, 344.2735827404177, 5296.682199068054, 5382.946170538294, 5396.8111116110995, 5421.620486565942, 5460.0, 5336.971950658744, 5349.8127565535215, 5361.865953351168, 5373.274607927929, 5374.811881584145, 4031.093004074089, 4093.3655283431117, 4250.61744443, 4260.656638848636, 4272.209641216369, 4228.851990180345, 4239.47006624172, 4245.490541135068, 4247.702660813744, 4260.957390426087, 3996.8601098961544, 4183.853565125221, 4188.832446702128, 4195.5175154857125, 4235.449391579091, 4096.487939007624, 4194.475690538683, 4204.8528301509305, 4206.390073439365, 4208.810603522848, 3710.870119545803, 3711.888643340704, 3720.0, 3722.8510859565586, 3732.9440058399146, 5170.224466330043, 5177.585793136578, 5178.9444227905715, 5194.6883187008525, 5200.6619569727845, 4478.193925093482, 4731.929021064687, 4748.406449193851, 4752.382190315271, 4764.666473346867, 5608.775648974036, 5618.690971996539, 5624.690642014688, 5639.069553523705, 5649.435056494318, 3995.720299579031, 4016.518017837849, 4018.799060046986, 4037.2934736421007, 4059.7564146151326, 5643.774249030034, 5795.797147099831, 5847.502962248172, 5870.295564532284, 5889.440503152194, 4047.615476529725, 4069.084455997436, 4075.694322925792, 4083.2650122977557, 4092.1815636872743, 4123.36087906375, 4133.173365326947, 4145.0880806222585, 4161.0, 4178.979105104455, 4579.427571553556, 4721.740304283228, 4728.54115859751, 4753.691010084333, 4784.373313073502, 5665.801696940587, 5669.177969194444, 5692.6299790513485, 5704.629199102128, 5711.286089238845, 1487.5537338798317, 1491.3818506920113, 1497.0, 1504.8645621894082, 1505.9247037648074, 936.0, 940.1444685336311, 1002.0060080439872, 1002.6139936124645, 1011.4234886114843, 5728.226689396878, 5827.184194212814, 5828.417158284137, 5832.650040997553, 5851.765929362778, 6114.877702446015, 6119.44924956756, 6144.463884028993, 6147.600405973598, 6154.876902461926, 5652.547796176296, 5834.24154859874, 5850.61970971894, 5850.970745146247, 5853.678047707332, 3241.173500757292, 3253.430649636304, 3261.1357990132633, 3261.967380326214, 3268.5587445694528, 5770.480656740913, 6099.96950015256, 6124.755009799647, 6300.369963003663, 6429.9678501607195, 5930.873134104507, 5950.85122871923, 5984.3417224105315, 5988.490978266809, 5993.670348130895, 5761.193432919478, 6117.602355846856, 6129.908051379233, 6140.754369825247, 6173.660448675366, 5850.912236316373, 5882.352941176553, 5915.645061296336, 5927.0, 5928.851778705394, 5813.76744930198, 5833.562482813721, 5835.241418615553, 5839.912401314069, 5855.677937713466, 5940.198073260228, 6137.754489820357, 6142.78500252489, 6160.7535698571555, 6175.3824617539685, 4093.8771836844944, 4126.690498212586, 4129.669626429938, 4151.8546850861285, 4153.0447996960265, 5850.414958504116, 5916.31962324321, 5925.585209035326, 5930.555208359477, 5938.168656388023, 5728.598998070262, 5741.5406767459335, 5783.190353350618, 5784.2191304175085, 5784.334801497714, 5676.290463692038, 5690.800821971211, 5724.313082430135, 5724.74238659253, 5762.0, 5356.12592540786, 5404.270423492778, 5593.860153496195, 5614.494695477427, 5677.687727175045, 5718.742656580381, 5720.456556627114, 5733.8566535836935, 5734.426557344399, 5762.337331206965, 5438.211459338453, 5589.5248903842, 5621.831345059655, 5626.662400255997, 5648.604597678287], "value": 4363.002994956018, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [858.6222062292587, 908.196246322005, 911.4258017449006, 920.5375620215923, 932.2262522106648, 14378.568642940701, 14628.561143165722, 14690.63273418165, 14716.0, 14736.557903262907, 14518.056326338781, 14522.0, 14544.781828272584, 14568.417263309455, 14614.415423383052, 762.211111499598, 888.0852721696663, 913.1462082952444, 925.9166674999249, 926.536731634183, 904.4934836491553, 912.6486302773413, 916.8533034714447, 918.0773322810566, 922.8615707643874, 958.4776296918161, 970.9950201541407, 973.1047436358567, 974.7027156717198, 974.7075877236836, 791.7901756034627, 943.0804965158984, 966.4829316315772, 967.8741763570725, 968.1335204991564, 705.2172088981226, 709.2588245283691, 709.8402859356655, 711.950163488556, 715.2597062040815, 14793.852061479463, 14794.63013424673, 14848.109113453227, 14854.034487758261, 14937.327820248114, 14412.711745765131, 14872.62818429537, 14875.776863347059, 14967.0, 15144.772828407582, 10671.893281067167, 10920.672379828618, 10940.671779846618, 11172.441377931153, 11408.486618102206, 3738.1962877981364, 3783.641082093462, 3809.923801523954, 3820.178661587772, 3829.2341531693774, 56417.0, 57727.71136144335, 58335.416645833844, 58910.70544647292, 59038.70480647569, 11491.253068550517, 11611.76776464466, 11623.07015438763, 11674.0, 11765.529378824922, 18506.0, 18980.715289270673, 20358.491037723878, 20647.690284645443, 20683.82819803929, 7684.423668224906, 7698.384129269645, 7701.730439434593, 7822.335101516434, 7866.881996770053, 4619.260918253063, 4637.118947399983, 4662.813487460531, 4856.805727770849, 4883.316335713003, 3371.679690429405, 3499.107727529464, 3500.43992961125, 3501.124718820295, 3504.9660350196755, 585.956897407889, 634.3244444666416, 645.6803882078401, 653.2422390027546, 654.2410803467955, 658.295623682655, 709.3048812164108, 754.5698951597647, 761.7638532055081, 773.5397438524069, 9553.856692149484, 9797.80404391908, 9798.608055677692, 9871.457069861226, 9907.504624768733, 800.3237264511479, 804.6120442237094, 814.8952491009273, 845.9534725590029, 850.5364576305928, 4429.269170586882, 4510.977445112753, 4543.363929049936, 4593.517680643551, 4695.671303008825, 66086.66956665186, 67068.32931670621, 67193.32806671968, 67477.0, 68351.3164868355, 57452.0, 57821.0, 59097.40902590919, 59194.0, 59534.40465595289, 52192.0, 52706.20940685893, 53155.73422132942, 53294.46705532895, 53897.730511347196, 8826.470411775314, 8946.776330591787, 8954.865677014719, 9076.273898088006, 9101.817963640558, 33674.158146046546, 34030.82984585061, 34820.129496762784, 35045.12387190341, 35556.466652999705, 46717.53282467132, 47304.7634761824, 47469.287960679925, 47817.28274075822, 48199.0, 11530.82703759461, 11555.653330400102, 11790.646280611596, 11891.82162267584, 11981.580644677395, 12848.103776578775, 12967.740645186856, 13151.868481315065, 13307.66730831737, 13400.396982135633, 12581.0, 13017.153884997444, 13152.342382880626, 13253.13854599448, 13283.185487093315, 12551.05867059956, 12699.238045717286, 12739.490420383081, 12789.488420463078, 13148.079634425498, 11999.700007499883, 12366.134370593973, 12507.374631268218, 13136.737265254833, 13180.275084870424, 10451.94774026125, 10453.0, 10556.736081598021, 10567.735806604896, 10775.137988961022, 10366.585336586451, 10504.789904202025, 10653.89346106529, 10734.355938643706, 10808.675739727822], "value": 7026.938222758158, "unit": "score"}], "name": "dromaeo_css", "value": 7209.3055149192305, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 106.0, 110.0, 111.0, 110.0, 100.0, 109.0, 110.0, 111.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 152.0, 187.0, 130.0, 158.0, 167.0, 128.0, 184.0, 128.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 162.0, 161.0, 160.0, 164.0, 161.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 169.0, 77.0, 77.0, 77.0, 76.0, 183.0, 76.0], "value": 96.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 155.0, 93.0, 92.0, 92.0, 161.0, 92.0, 91.0, 146.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 144.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 96.0, 94.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 76.0, 57.0, 55.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 57.0, 58.0, 58.0, 58.0, 59.0, 59.0, 58.0, 58.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 73.0, 74.0, 82.0, 75.0, 74.0, 75.0, 74.0, 81.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 116.0, 121.0, 119.0, 119.0, 124.0, 127.0, 157.0, 124.0], "value": 124.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 156.0, 158.0, 158.0, 162.0, 172.0, 158.0, 157.0, 157.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 67.0, 65.0, 65.0, 69.0, 66.0, 65.0, 66.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1530.0999999999997, "alertThreshold": 2.0}]} 03:37:20 INFO - Return code: 0 03:37:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:37:20 ERROR - # TBPL SUCCESS # 03:37:20 INFO - Running post-action listener: _resource_record_post_action 03:37:20 INFO - Running post-run listener: _resource_record_post_run 03:37:21 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 504741888; Read time: 24; Write time: 716020 03:37:21 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 253763584; Read time: 0; Write time: 430540 03:37:21 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 247558144; Read time: 24; Write time: 284540 03:37:21 INFO - Running post-run listener: _upload_blobber_files 03:37:21 INFO - Blob upload gear active. 03:37:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:37:21 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:37:21 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:37:21 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:37:22 INFO - (blobuploader) - INFO - Open directory for files ... 03:37:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:37:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:37:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:25 INFO - (blobuploader) - INFO - Done attempting. 03:37:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:37:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:37:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:26 INFO - (blobuploader) - INFO - Done attempting. 03:37:26 INFO - (blobuploader) - INFO - Iteration through files over. 03:37:26 INFO - Return code: 0 03:37:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:37:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:37:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/55c8dde64e5f3b88638f660f47bab1e02b2d8e7b4d4b50e308a7d02ed610f2decd54a95a8873aa5a883206669ebb622f82cb387d36484b36d14e0417cc532cb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ae4483bb9d96a4236c4428042c312ae3815e885b740c9473b0aacff44d1c387595d36b318a03f787ce9b1f43acec30acaf25435110a51df51c6fad86f4ac060"} 03:37:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:37:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:37:26 INFO - Contents: 03:37:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/55c8dde64e5f3b88638f660f47bab1e02b2d8e7b4d4b50e308a7d02ed610f2decd54a95a8873aa5a883206669ebb622f82cb387d36484b36d14e0417cc532cb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ae4483bb9d96a4236c4428042c312ae3815e885b740c9473b0aacff44d1c387595d36b318a03f787ce9b1f43acec30acaf25435110a51df51c6fad86f4ac060"} 03:37:26 INFO - Running post-run listener: copy_logs_to_upload_dir 03:37:26 INFO - Copying logs to upload dir... 03:37:26 INFO - mkdir: /builds/slave/test/build/upload/logs 03:37:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.796077 ========= master_lag: 0.84 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-06 03:37:26.635579) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 03:37:26.642956) ========= 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=c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981 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/55c8dde64e5f3b88638f660f47bab1e02b2d8e7b4d4b50e308a7d02ed610f2decd54a95a8873aa5a883206669ebb622f82cb387d36484b36d14e0417cc532cb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ae4483bb9d96a4236c4428042c312ae3815e885b740c9473b0aacff44d1c387595d36b318a03f787ce9b1f43acec30acaf25435110a51df51c6fad86f4ac060"} 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.011220 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/55c8dde64e5f3b88638f660f47bab1e02b2d8e7b4d4b50e308a7d02ed610f2decd54a95a8873aa5a883206669ebb622f82cb387d36484b36d14e0417cc532cb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ae4483bb9d96a4236c4428042c312ae3815e885b740c9473b0aacff44d1c387595d36b318a03f787ce9b1f43acec30acaf25435110a51df51c6fad86f4ac060"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 03:37:26.670592) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:37:26.670948) ========= 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=c6927cf182745ad25b1d38b9000001fe-1462529814.801557-945760981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:37:26.721277) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 03:37:26.724658) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 03:37:26.724952) ========= ========= Total master_lag: 0.96 =========