builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1462533673.77 results: success (0) buildid: 20160506013623 builduid: 3e330e94e72a44aabac68afc380e9ed1 revision: b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:13.767257) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:13.767898) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:13.768338) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:13.786019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:13.786617) ========= 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=523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 04:21:15-- 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% 66.9M=0s 2016-05-06 04:21:15 (66.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104868 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:13.906104) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:13.906442) ========= 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=523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018969 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:13.957127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 04:21:13.957507) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f --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 b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f --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=523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 04:21:15,335 truncating revision to first 12 chars 2016-05-06 04:21:15,335 Setting DEBUG logging. 2016-05-06 04:21:15,335 attempt 1/10 2016-05-06 04:21:15,335 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b61ad3a6049c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 04:21:16,565 unpacking tar archive at: mozilla-aurora-b61ad3a6049c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.507275 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 04:21:15.480087) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:15.480439) ========= script_repo_revision: b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:15.480861) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:15.481339) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 04:21:15.491517) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-06 04:21:15.491851) ========= /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=523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:21:16 INFO - MultiFileLogger online at 20160506 04:21:16 in /builds/slave/test 04:21:16 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 04:21:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:21:16 INFO - {'append_to_log': False, 04:21:16 INFO - 'base_work_dir': '/builds/slave/test', 04:21:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:21:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:21:16 INFO - 'branch': 'Mozilla-Aurora', 04:21:16 INFO - 'buildbot_json_path': 'buildprops.json', 04:21:16 INFO - 'config_files': ('talos/linux_config.py',), 04:21:16 INFO - 'default_actions': ('clobber', 04:21:16 INFO - 'read-buildbot-config', 04:21:16 INFO - 'download-and-extract', 04:21:16 INFO - 'populate-webroot', 04:21:16 INFO - 'create-virtualenv', 04:21:16 INFO - 'install', 04:21:16 INFO - 'run-tests'), 04:21:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:21:16 INFO - 'download_minidump_stackwalk': True, 04:21:16 INFO - 'download_symbols': 'ondemand', 04:21:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:21:16 INFO - 'tooltool.py': '/tools/tooltool.py', 04:21:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:21:16 INFO - '/tools/misc-python/virtualenv.py')}, 04:21:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:21:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:21:16 INFO - 'installer_path': 'installer.exe', 04:21:16 INFO - 'log_level': 'info', 04:21:16 INFO - 'log_name': 'talos', 04:21:16 INFO - 'log_to_console': True, 04:21:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:21:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:21:16 INFO - 'opt_config_files': (), 04:21:16 INFO - 'pip_index': False, 04:21:16 INFO - 'sps_profile': False, 04:21:16 INFO - 'sps_profile_interval': 0, 04:21:16 INFO - 'suite': 'dromaeojs', 04:21:16 INFO - 'system_bits': '32', 04:21:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:21:16 INFO - 'title': 'talos-linux64-ix-065', 04:21:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:21:16 INFO - 'use_talos_json': True, 04:21:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:21:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:21:16 INFO - 'work_dir': 'build'} 04:21:16 INFO - ##### 04:21:16 INFO - ##### Running clobber step. 04:21:16 INFO - ##### 04:21:16 INFO - Running pre-action listener: _resource_record_pre_action 04:21:16 INFO - Running main action method: clobber 04:21:16 INFO - rmtree: /builds/slave/test/build 04:21:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:21:17 INFO - Running post-action listener: _resource_record_post_action 04:21:17 INFO - ##### 04:21:17 INFO - ##### Running read-buildbot-config step. 04:21:17 INFO - ##### 04:21:17 INFO - Running pre-action listener: _resource_record_pre_action 04:21:17 INFO - Running main action method: read_buildbot_config 04:21:17 INFO - Using buildbot properties: 04:21:17 INFO - { 04:21:17 INFO - "project": "", 04:21:17 INFO - "product": "firefox", 04:21:17 INFO - "script_repo_revision": "production", 04:21:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:21:17 INFO - "repository": "", 04:21:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:21:17 INFO - "buildid": "20160506013623", 04:21:17 INFO - "pgo_build": "True", 04:21:17 INFO - "basedir": "/builds/slave/test", 04:21:17 INFO - "buildnumber": 490, 04:21:17 INFO - "slavename": "talos-linux64-ix-065", 04:21:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:21:17 INFO - "platform": "ubuntu64_hw", 04:21:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:21:17 INFO - "branch": "mozilla-aurora", 04:21:17 INFO - "repo_path": "releases/mozilla-aurora", 04:21:17 INFO - "revision": "b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f", 04:21:17 INFO - "stage_platform": "linux64-pgo", 04:21:17 INFO - "builduid": "3e330e94e72a44aabac68afc380e9ed1", 04:21:17 INFO - "slavebuilddir": "test" 04:21:17 INFO - } 04:21:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 04:21:17 INFO - Running post-action listener: _resource_record_post_action 04:21:17 INFO - ##### 04:21:17 INFO - ##### Running download-and-extract step. 04:21:17 INFO - ##### 04:21:17 INFO - Running pre-action listener: _resource_record_pre_action 04:21:17 INFO - Running main action method: download_and_extract 04:21:17 INFO - mkdir: /builds/slave/test/build/tests 04:21: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')]} 04:21:17 INFO - https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:21:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:21:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:21:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:21:18 INFO - Downloaded 1361 bytes. 04:21:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:21:18 INFO - Using the following test package requirements: 04:21:18 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:21:18 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:21:18 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:21:18 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:18 INFO - u'jsshell-linux-x86_64.zip'], 04:21:18 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:21:18 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:21:18 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:21:18 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:21:18 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:21:18 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:21:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:21:18 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:18 INFO - https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:21:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:21:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:21:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:21:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:21:19 INFO - Downloaded 23799377 bytes. 04:21:19 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'] 04:21:19 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 04:21:20 INFO - Return code: 0 04:21:20 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 04:21: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')]} 04:21:20 INFO - https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:21:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:21:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:21:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:21:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:21:21 INFO - Downloaded 23799377 bytes. 04:21:21 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'] 04:21:21 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 04:21:23 INFO - Return code: 0 04:21:23 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')]} 04:21:23 INFO - https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:21:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:21:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:21:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:21:24 INFO - Downloaded 10840145 bytes. 04:21:24 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'] 04:21:24 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 04:21:24 INFO - Return code: 0 04:21: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')]} 04:21:24 INFO - https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:21:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:21:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:21:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:21:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZULdrJzSvuOvylse2l50g/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 04:21:25 INFO - Downloaded 62706998 bytes. 04:21:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:21:25 INFO - mkdir: /builds/slave/test/properties 04:21:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:21:25 INFO - Writing to file /builds/slave/test/properties/build_url 04:21:25 INFO - Contents: 04:21:25 INFO - build_url:https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:21:26 INFO - Running post-action listener: _resource_record_post_action 04:21:26 INFO - Running post-action listener: set_extra_try_arguments 04:21:26 INFO - ##### 04:21:26 INFO - ##### Running populate-webroot step. 04:21:26 INFO - ##### 04:21:26 INFO - Running pre-action listener: _resource_record_pre_action 04:21:26 INFO - Running main action method: populate_webroot 04:21:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:21:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:21:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:21:26 INFO - '--tppagecycles', 04:21:26 INFO - '7'], 04:21:26 INFO - 'tests': ['tsvgm']}}, 04:21:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:21:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:21:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:21:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:21:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:21:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:21:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:26 INFO - 'talos_options': ['--disable-e10s'], 04:21:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:26 INFO - 'talos_options': ['--disable-e10s'], 04:21:26 INFO - 'tests': ['damp', 'tps']}, 04:21:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:26 INFO - 'tests': ['damp', 'tps']}, 04:21:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:21:26 INFO - 'tests': ['dromaeo_dom']}, 04:21:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:21:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:21:26 INFO - 'tests': ['a11yr', 04:21:26 INFO - 'ts_paint', 04:21:26 INFO - 'tpaint', 04:21:26 INFO - 'sessionrestore', 04:21:26 INFO - 'sessionrestore_no_auto_restore', 04:21:26 INFO - 'tabpaint']}, 04:21:26 INFO - 'other-e10s': {'tests': ['a11yr', 04:21:26 INFO - 'ts_paint', 04:21:26 INFO - 'tpaint', 04:21:26 INFO - 'sessionrestore', 04:21:26 INFO - 'sessionrestore_no_auto_restore', 04:21:26 INFO - 'tabpaint']}, 04:21:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:21:26 INFO - 'ts_paint', 04:21:26 INFO - 'tpaint', 04:21:26 INFO - 'sessionrestore', 04:21:26 INFO - 'sessionrestore_no_auto_restore', 04:21:26 INFO - 'tabpaint']}, 04:21:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:21:26 INFO - 'ts_paint', 04:21:26 INFO - 'tpaint', 04:21:26 INFO - 'sessionrestore', 04:21:26 INFO - 'sessionrestore_no_auto_restore', 04:21:26 INFO - 'tabpaint']}, 04:21:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:21:26 INFO - 'tests': ['a11yr', 04:21:26 INFO - 'ts_paint', 04:21:26 INFO - 'tpaint', 04:21:26 INFO - 'sessionrestore', 04:21:26 INFO - 'sessionrestore_no_auto_restore', 04:21:26 INFO - 'tabpaint']}, 04:21:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:21:26 INFO - 'tests': ['a11yr', 04:21:26 INFO - 'ts_paint', 04:21:26 INFO - 'tpaint', 04:21:26 INFO - 'sessionrestore', 04:21:26 INFO - 'sessionrestore_no_auto_restore', 04:21:26 INFO - 'tabpaint']}, 04:21:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:21:26 INFO - 'tests': ['tsvgx', 04:21:26 INFO - 'tsvgr_opacity', 04:21:26 INFO - 'tart', 04:21:26 INFO - 'tscrollx', 04:21:26 INFO - 'cart']}, 04:21:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:21:26 INFO - 'tsvgr_opacity', 04:21:26 INFO - 'tart', 04:21:26 INFO - 'tscrollx', 04:21:26 INFO - 'cart']}, 04:21:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:26 INFO - 'talos_options': ['--disable-e10s'], 04:21:26 INFO - 'tests': ['tp5o']}, 04:21:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:26 INFO - 'tests': ['tp5o']}, 04:21:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:26 INFO - 'talos_options': ['--disable-e10s', 04:21:26 INFO - '--xperf_path', 04:21:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:26 INFO - 'tests': ['tp5n']}, 04:21:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:26 INFO - 'talos_options': ['--xperf_path', 04:21:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:26 INFO - 'tests': ['tp5n']}}, 04:21:26 INFO - 'talos.zip': {'path': '', 04:21:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:21:26 INFO - Running post-action listener: _resource_record_post_action 04:21:26 INFO - ##### 04:21:26 INFO - ##### Running create-virtualenv step. 04:21:26 INFO - ##### 04:21:26 INFO - Running pre-action listener: _resource_record_pre_action 04:21:26 INFO - Running main action method: create_virtualenv 04:21:26 INFO - Creating virtualenv /builds/slave/test/build/venv 04:21:26 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 04:21:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:21:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:21:26 INFO - Using real prefix '/usr' 04:21:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:21:27 INFO - Installing distribute.............................................................................................................................................................................................done. 04:21:29 INFO - Installing pip.................done. 04:21:29 INFO - Return code: 0 04:21:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:29 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 0x7f464ea17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793410>, '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 0x1794310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17947a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', '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 04:21:29 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 04:21:29 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 04:21:29 INFO - Using env: {'DISPLAY': ':0', 04:21:29 INFO - 'HOME': '/home/cltbld', 04:21:29 INFO - 'LANG': 'en_US.UTF-8', 04:21:29 INFO - 'LANGUAGE': 'en_US:en', 04:21:29 INFO - 'LOGNAME': 'cltbld', 04:21:29 INFO - 'MAIL': '/var/mail/cltbld', 04:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:29 INFO - 'MOZ_NO_REMOTE': '1', 04:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:29 INFO - 'NO_EM_RESTART': '1', 04:21:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:29 INFO - 'PWD': '/builds/slave/test', 04:21:29 INFO - 'SHELL': '/bin/bash', 04:21:29 INFO - 'SHLVL': '1', 04:21:29 INFO - 'TERM': 'linux', 04:21:29 INFO - 'TMOUT': '86400', 04:21:29 INFO - 'USER': 'cltbld', 04:21:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', 04:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:29 INFO - '_': '/tools/buildbot/bin/python'} 04:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:29 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 04:21:29 INFO - Cleaning up... 04:21:29 INFO - Return code: 0 04:21:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:29 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 0x7f464ea17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793410>, '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 0x1794310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17947a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', '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 04:21:29 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 04:21:29 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 04:21:29 INFO - Using env: {'DISPLAY': ':0', 04:21:29 INFO - 'HOME': '/home/cltbld', 04:21:29 INFO - 'LANG': 'en_US.UTF-8', 04:21:29 INFO - 'LANGUAGE': 'en_US:en', 04:21:29 INFO - 'LOGNAME': 'cltbld', 04:21:29 INFO - 'MAIL': '/var/mail/cltbld', 04:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:29 INFO - 'MOZ_NO_REMOTE': '1', 04:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:29 INFO - 'NO_EM_RESTART': '1', 04:21:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:29 INFO - 'PWD': '/builds/slave/test', 04:21:29 INFO - 'SHELL': '/bin/bash', 04:21:29 INFO - 'SHLVL': '1', 04:21:29 INFO - 'TERM': 'linux', 04:21:29 INFO - 'TMOUT': '86400', 04:21:29 INFO - 'USER': 'cltbld', 04:21:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', 04:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:29 INFO - '_': '/tools/buildbot/bin/python'} 04:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:29 INFO - Downloading/unpacking psutil>=0.7.1 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:21:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:31 INFO - Installing collected packages: psutil 04:21:31 INFO - Running setup.py install for psutil 04:21:31 INFO - building 'psutil._psutil_linux' extension 04:21:31 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 04:21:31 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 04:21:31 INFO - building 'psutil._psutil_posix' extension 04:21:31 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 04:21:32 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 04:21:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:32 INFO - Successfully installed psutil 04:21:32 INFO - Cleaning up... 04:21:32 INFO - Return code: 0 04:21:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:21:32 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')]} 04:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:32 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')]} 04:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:32 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 0x7f464ea17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793410>, '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 0x1794310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17947a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', '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 04:21:32 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 04:21:32 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 04:21:32 INFO - Using env: {'DISPLAY': ':0', 04:21:32 INFO - 'HOME': '/home/cltbld', 04:21:32 INFO - 'LANG': 'en_US.UTF-8', 04:21:32 INFO - 'LANGUAGE': 'en_US:en', 04:21:32 INFO - 'LOGNAME': 'cltbld', 04:21:32 INFO - 'MAIL': '/var/mail/cltbld', 04:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:32 INFO - 'MOZ_NO_REMOTE': '1', 04:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:32 INFO - 'NO_EM_RESTART': '1', 04:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:32 INFO - 'PWD': '/builds/slave/test', 04:21:32 INFO - 'SHELL': '/bin/bash', 04:21:32 INFO - 'SHLVL': '1', 04:21:32 INFO - 'TERM': 'linux', 04:21:32 INFO - 'TMOUT': '86400', 04:21:32 INFO - 'USER': 'cltbld', 04:21:32 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', 04:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:32 INFO - '_': '/tools/buildbot/bin/python'} 04:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:21:32 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 04:21:32 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 04:21:32 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 04:21:32 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 04:21:32 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 04:21:32 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 04:21:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:21:34 INFO - Installing collected packages: mozsystemmonitor 04:21:34 INFO - Running setup.py install for mozsystemmonitor 04:21:34 INFO - Successfully installed mozsystemmonitor 04:21:34 INFO - Cleaning up... 04:21:34 INFO - Return code: 0 04:21:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:34 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 0x7f464ea17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793410>, '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 0x1794310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17947a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', '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 04:21:34 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 04:21:34 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 04:21:34 INFO - Using env: {'DISPLAY': ':0', 04:21:34 INFO - 'HOME': '/home/cltbld', 04:21:34 INFO - 'LANG': 'en_US.UTF-8', 04:21:34 INFO - 'LANGUAGE': 'en_US:en', 04:21:34 INFO - 'LOGNAME': 'cltbld', 04:21:34 INFO - 'MAIL': '/var/mail/cltbld', 04:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:34 INFO - 'MOZ_NO_REMOTE': '1', 04:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:34 INFO - 'NO_EM_RESTART': '1', 04:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:34 INFO - 'PWD': '/builds/slave/test', 04:21:34 INFO - 'SHELL': '/bin/bash', 04:21:34 INFO - 'SHLVL': '1', 04:21:34 INFO - 'TERM': 'linux', 04:21:34 INFO - 'TMOUT': '86400', 04:21:34 INFO - 'USER': 'cltbld', 04:21:34 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', 04:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:34 INFO - '_': '/tools/buildbot/bin/python'} 04:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:34 INFO - Downloading/unpacking blobuploader==1.2.4 04:21:34 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 04:21:34 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 04:21:34 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 04:21:34 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 04:21:34 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 04:21:34 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 04:21:36 INFO - Downloading blobuploader-1.2.4.tar.gz 04:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:21:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:21:36 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 04:21:36 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 04:21:36 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 04:21:36 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 04:21:36 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 04:21:36 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 04:21:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:21:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:21:37 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 04:21:37 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 04:21:37 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 04:21:37 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 04:21:37 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 04:21:37 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 04:21:37 INFO - Downloading docopt-0.6.1.tar.gz 04:21:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:21:37 INFO - Installing collected packages: blobuploader, requests, docopt 04:21:37 INFO - Running setup.py install for blobuploader 04:21:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:21:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:21:37 INFO - Running setup.py install for requests 04:21:37 INFO - Running setup.py install for docopt 04:21:37 INFO - Successfully installed blobuploader requests docopt 04:21:37 INFO - Cleaning up... 04:21:38 INFO - Return code: 0 04:21:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:38 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 0x7f464ea17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793410>, '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 0x1794310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17947a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', '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 04:21:38 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 04:21:38 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 04:21:38 INFO - Using env: {'DISPLAY': ':0', 04:21:38 INFO - 'HOME': '/home/cltbld', 04:21:38 INFO - 'LANG': 'en_US.UTF-8', 04:21:38 INFO - 'LANGUAGE': 'en_US:en', 04:21:38 INFO - 'LOGNAME': 'cltbld', 04:21:38 INFO - 'MAIL': '/var/mail/cltbld', 04:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:38 INFO - 'MOZ_NO_REMOTE': '1', 04:21:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:38 INFO - 'NO_EM_RESTART': '1', 04:21:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:38 INFO - 'PWD': '/builds/slave/test', 04:21:38 INFO - 'SHELL': '/bin/bash', 04:21:38 INFO - 'SHLVL': '1', 04:21:38 INFO - 'TERM': 'linux', 04:21:38 INFO - 'TMOUT': '86400', 04:21:38 INFO - 'USER': 'cltbld', 04:21:38 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', 04:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:38 INFO - '_': '/tools/buildbot/bin/python'} 04:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:38 INFO - Running setup.py (path:/tmp/pip-XaC5Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:38 INFO - Running setup.py (path:/tmp/pip-ERH4MP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:38 INFO - Running setup.py (path:/tmp/pip-DyiuqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:38 INFO - Running setup.py (path:/tmp/pip-0fmXrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:38 INFO - Running setup.py (path:/tmp/pip-GUS2oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:38 INFO - Running setup.py (path:/tmp/pip-OxU1z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:38 INFO - Running setup.py (path:/tmp/pip-tSf2HL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:38 INFO - Running setup.py (path:/tmp/pip-ez1F9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:38 INFO - Running setup.py (path:/tmp/pip-9hgZyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:38 INFO - Running setup.py (path:/tmp/pip-FLOpeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:38 INFO - Running setup.py (path:/tmp/pip-zHInWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:39 INFO - Running setup.py (path:/tmp/pip-oe78VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:39 INFO - Running setup.py (path:/tmp/pip-L4IlBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:39 INFO - Running setup.py (path:/tmp/pip-zYlM3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:39 INFO - Running setup.py (path:/tmp/pip-lTRf5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:39 INFO - Running setup.py (path:/tmp/pip-99tZGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:39 INFO - Running setup.py (path:/tmp/pip-yywsnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:21:39 INFO - Running setup.py install for manifestparser 04:21:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:21:39 INFO - Running setup.py install for mozcrash 04:21:39 INFO - Running setup.py install for mozdebug 04:21:39 INFO - Running setup.py install for mozdevice 04:21:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:21:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:21:39 INFO - Running setup.py install for mozfile 04:21:40 INFO - Running setup.py install for mozhttpd 04:21:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:21:40 INFO - Running setup.py install for mozinfo 04:21:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:21:40 INFO - Running setup.py install for mozInstall 04:21:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:21:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:21:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:21:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:21:40 INFO - Running setup.py install for mozleak 04:21:40 INFO - Running setup.py install for mozlog 04:21:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:21:40 INFO - Running setup.py install for moznetwork 04:21:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:21:40 INFO - Running setup.py install for mozprocess 04:21:40 INFO - Running setup.py install for mozprofile 04:21:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:21:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:21:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:21:40 INFO - Running setup.py install for mozrunner 04:21:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:21:40 INFO - Running setup.py install for mozscreenshot 04:21:41 INFO - Running setup.py install for moztest 04:21:41 INFO - Running setup.py install for mozversion 04:21:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:21:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:21:41 INFO - Cleaning up... 04:21:41 INFO - Return code: 0 04:21:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:41 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')]} 04:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:41 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')]} 04:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:41 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 0x7f464ea17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793410>, '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 0x1794310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17947a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', '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 04:21:41 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 04:21:41 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 04:21:41 INFO - Using env: {'DISPLAY': ':0', 04:21:41 INFO - 'HOME': '/home/cltbld', 04:21:41 INFO - 'LANG': 'en_US.UTF-8', 04:21:41 INFO - 'LANGUAGE': 'en_US:en', 04:21:41 INFO - 'LOGNAME': 'cltbld', 04:21:41 INFO - 'MAIL': '/var/mail/cltbld', 04:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:41 INFO - 'MOZ_NO_REMOTE': '1', 04:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:41 INFO - 'NO_EM_RESTART': '1', 04:21:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:41 INFO - 'PWD': '/builds/slave/test', 04:21:41 INFO - 'SHELL': '/bin/bash', 04:21:41 INFO - 'SHLVL': '1', 04:21:41 INFO - 'TERM': 'linux', 04:21:41 INFO - 'TMOUT': '86400', 04:21:41 INFO - 'USER': 'cltbld', 04:21:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', 04:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:41 INFO - '_': '/tools/buildbot/bin/python'} 04:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:41 INFO - Running setup.py (path:/tmp/pip-G7VnL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:41 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)) 04:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:41 INFO - Running setup.py (path:/tmp/pip-stNBbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:41 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)) 04:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:41 INFO - Running setup.py (path:/tmp/pip-dVAnzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:41 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)) 04:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:41 INFO - Running setup.py (path:/tmp/pip-4vtx5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:41 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)) 04:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:41 INFO - Running setup.py (path:/tmp/pip-WfB1Az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:41 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)) 04:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:41 INFO - Running setup.py (path:/tmp/pip-NNe8Uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:41 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)) 04:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:41 INFO - Running setup.py (path:/tmp/pip-zfPtrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:42 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)) 04:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:42 INFO - Running setup.py (path:/tmp/pip-hiZBs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:42 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)) 04:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:42 INFO - Running setup.py (path:/tmp/pip-xXP4nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:42 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)) 04:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:42 INFO - Running setup.py (path:/tmp/pip-Tx_BWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:42 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)) 04:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:42 INFO - Running setup.py (path:/tmp/pip-DEnMHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:42 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)) 04:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:42 INFO - Running setup.py (path:/tmp/pip-2dcxTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:42 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)) 04:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:42 INFO - Running setup.py (path:/tmp/pip-35cYDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:42 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)) 04:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:42 INFO - Running setup.py (path:/tmp/pip-Vu6AQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:42 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)) 04:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:42 INFO - Running setup.py (path:/tmp/pip-uO1z1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:42 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)) 04:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:42 INFO - Running setup.py (path:/tmp/pip-q4FvLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:42 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)) 04:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:42 INFO - Running setup.py (path:/tmp/pip-PEruor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:42 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)) 04:21:42 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)) 04:21:42 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)) 04:21:42 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)) 04:21:42 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)) 04:21:42 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)) 04:21:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:21:42 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 04:21:42 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 04:21:42 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 04:21:42 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 04:21:42 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 04:21:42 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 04:21:44 INFO - Downloading blessings-1.6.tar.gz 04:21:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:21:44 INFO - Installing collected packages: blessings 04:21:44 INFO - Running setup.py install for blessings 04:21:44 INFO - Successfully installed blessings 04:21:44 INFO - Cleaning up... 04:21:44 INFO - Return code: 0 04:21:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:21:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:45 INFO - Reading from file tmpfile_stdout 04:21:45 INFO - Current package versions: 04:21:45 INFO - argparse == 1.2.1 04:21:45 INFO - blessings == 1.6 04:21:45 INFO - blobuploader == 1.2.4 04:21:45 INFO - docopt == 0.6.1 04:21:45 INFO - manifestparser == 1.1 04:21:45 INFO - mozInstall == 1.12 04:21:45 INFO - mozcrash == 0.17 04:21:45 INFO - mozdebug == 0.1 04:21:45 INFO - mozdevice == 0.48 04:21:45 INFO - mozfile == 1.2 04:21:45 INFO - mozhttpd == 0.7 04:21:45 INFO - mozinfo == 0.9 04:21:45 INFO - mozleak == 0.1 04:21:45 INFO - mozlog == 3.1 04:21:45 INFO - moznetwork == 0.27 04:21:45 INFO - mozprocess == 0.22 04:21:45 INFO - mozprofile == 0.28 04:21:45 INFO - mozrunner == 6.11 04:21:45 INFO - mozscreenshot == 0.1 04:21:45 INFO - mozsystemmonitor == 0.0 04:21:45 INFO - moztest == 0.7 04:21:45 INFO - mozversion == 1.4 04:21:45 INFO - psutil == 3.1.1 04:21:45 INFO - requests == 1.2.3 04:21:45 INFO - wsgiref == 0.1.2 04:21:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:45 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')]} 04:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:45 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')]} 04:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:45 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 0x7f464ea17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793410>, '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 0x1794310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17947a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', '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 04:21:45 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 04:21:45 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 04:21:45 INFO - Using env: {'DISPLAY': ':0', 04:21:45 INFO - 'HOME': '/home/cltbld', 04:21:45 INFO - 'LANG': 'en_US.UTF-8', 04:21:45 INFO - 'LANGUAGE': 'en_US:en', 04:21:45 INFO - 'LOGNAME': 'cltbld', 04:21:45 INFO - 'MAIL': '/var/mail/cltbld', 04:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:45 INFO - 'MOZ_NO_REMOTE': '1', 04:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:45 INFO - 'NO_EM_RESTART': '1', 04:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:45 INFO - 'PWD': '/builds/slave/test', 04:21:45 INFO - 'SHELL': '/bin/bash', 04:21:45 INFO - 'SHLVL': '1', 04:21:45 INFO - 'TERM': 'linux', 04:21:45 INFO - 'TMOUT': '86400', 04:21:45 INFO - 'USER': 'cltbld', 04:21:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', 04:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:45 INFO - '_': '/tools/buildbot/bin/python'} 04:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:45 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)) 04:21:45 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)) 04:21:45 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)) 04:21:45 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)) 04:21:45 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)) 04:21:45 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)) 04:21:45 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)) 04:21:45 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)) 04:21:45 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)) 04:21:45 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)) 04:21:45 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)) 04:21:45 INFO - Cleaning up... 04:21:45 INFO - Return code: 0 04:21:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:21:45 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')]} 04:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:45 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')]} 04:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:45 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 0x7f464ea17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793410>, '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 0x1794310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17947a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', '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 04:21:45 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 04:21:45 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 04:21:45 INFO - Using env: {'DISPLAY': ':0', 04:21:45 INFO - 'HOME': '/home/cltbld', 04:21:45 INFO - 'LANG': 'en_US.UTF-8', 04:21:45 INFO - 'LANGUAGE': 'en_US:en', 04:21:45 INFO - 'LOGNAME': 'cltbld', 04:21:45 INFO - 'MAIL': '/var/mail/cltbld', 04:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:45 INFO - 'MOZ_NO_REMOTE': '1', 04:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:45 INFO - 'NO_EM_RESTART': '1', 04:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:45 INFO - 'PWD': '/builds/slave/test', 04:21:45 INFO - 'SHELL': '/bin/bash', 04:21:45 INFO - 'SHLVL': '1', 04:21:45 INFO - 'TERM': 'linux', 04:21:45 INFO - 'TMOUT': '86400', 04:21:45 INFO - 'USER': 'cltbld', 04:21:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', 04:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:45 INFO - '_': '/tools/buildbot/bin/python'} 04:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:45 INFO - Downloading/unpacking jsonschema 04:21:45 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 04:21:45 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 04:21:45 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 04:21:45 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 04:21:45 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 04:21:45 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 04:21:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:21:47 INFO - Downloading/unpacking functools32 (from jsonschema) 04:21:47 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 04:21:47 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 04:21:47 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 04:21:47 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 04:21:47 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 04:21:47 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 04:21:47 INFO - Downloading functools32-3.2.3-2.tar.gz 04:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:21:47 INFO - warning: no files found matching '*.txt' 04:21:47 INFO - no previously-included directories found matching 'build' 04:21:47 INFO - no previously-included directories found matching 'dist' 04:21:47 INFO - no previously-included directories found matching '.git*' 04:21:47 INFO - Installing collected packages: jsonschema, functools32 04:21:47 INFO - Running setup.py install for functools32 04:21:47 INFO - warning: no files found matching '*.txt' 04:21:47 INFO - no previously-included directories found matching 'build' 04:21:47 INFO - no previously-included directories found matching 'dist' 04:21:47 INFO - no previously-included directories found matching '.git*' 04:21:47 INFO - Successfully installed jsonschema functools32 04:21:47 INFO - Cleaning up... 04:21:47 INFO - Return code: 0 04:21:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:21:47 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')]} 04:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:47 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')]} 04:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:47 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 0x7f464ea17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1793410>, '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 0x1794310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17947a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', '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 04:21:47 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 04:21:47 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 04:21:47 INFO - Using env: {'DISPLAY': ':0', 04:21:47 INFO - 'HOME': '/home/cltbld', 04:21:47 INFO - 'LANG': 'en_US.UTF-8', 04:21:47 INFO - 'LANGUAGE': 'en_US:en', 04:21:47 INFO - 'LOGNAME': 'cltbld', 04:21:47 INFO - 'MAIL': '/var/mail/cltbld', 04:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:47 INFO - 'MOZ_NO_REMOTE': '1', 04:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:47 INFO - 'NO_EM_RESTART': '1', 04:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:47 INFO - 'PWD': '/builds/slave/test', 04:21:47 INFO - 'SHELL': '/bin/bash', 04:21:47 INFO - 'SHLVL': '1', 04:21:47 INFO - 'TERM': 'linux', 04:21:47 INFO - 'TMOUT': '86400', 04:21:47 INFO - 'USER': 'cltbld', 04:21:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', 04:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:47 INFO - '_': '/tools/buildbot/bin/python'} 04:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:48 INFO - Downloading/unpacking flake8 04:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:21:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:21:49 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 04:21:49 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 04:21:49 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 04:21:49 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 04:21:49 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 04:21:49 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 04:21:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:21:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:21:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:21:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:21:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:21:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:21:50 INFO - no previously-included directories found matching 'docs/_build' 04:21:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:21:50 INFO - Running setup.py install for pep8 04:21:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:21:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:21:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:21:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:21:50 INFO - no previously-included directories found matching 'docs/_build' 04:21:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:21:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:21:50 INFO - Cleaning up... 04:21:50 INFO - Return code: 0 04:21:50 INFO - Running post-action listener: _resource_record_post_action 04:21:50 INFO - Running post-action listener: _start_resource_monitoring 04:21:50 INFO - Starting resource monitoring. 04:21:50 INFO - ##### 04:21:50 INFO - ##### Running install step. 04:21:50 INFO - ##### 04:21:50 INFO - Running pre-action listener: _resource_record_pre_action 04:21:50 INFO - Running main action method: install 04:21:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:51 INFO - Reading from file tmpfile_stdout 04:21:51 INFO - Detecting whether we're running mozinstall >=1.0... 04:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:21:51 INFO - Reading from file tmpfile_stdout 04:21:51 INFO - Output received: 04:21:51 INFO - Usage: mozinstall [options] installer 04:21:51 INFO - Options: 04:21:51 INFO - -h, --help show this help message and exit 04:21:51 INFO - -d DEST, --destination=DEST 04:21:51 INFO - Directory to install application into. [default: 04:21:51 INFO - "/builds/slave/test"] 04:21:51 INFO - --app=APP Application being installed. [default: firefox] 04:21:51 INFO - mkdir: /builds/slave/test/build/application 04:21:51 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'] 04:21:51 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 04:22:06 INFO - Reading from file tmpfile_stdout 04:22:06 INFO - Output received: 04:22:06 INFO - /builds/slave/test/build/application/firefox/firefox 04:22:06 INFO - Running post-action listener: _resource_record_post_action 04:22:06 INFO - ##### 04:22:06 INFO - ##### Running run-tests step. 04:22:06 INFO - ##### 04:22:06 INFO - Running pre-action listener: _resource_record_pre_action 04:22:06 INFO - Running main action method: run_tests 04:22:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:22:06 INFO - Python 2.7.3 04:22:06 INFO - Return code: 0 04:22:06 INFO - grabbing minidump binary from tooltool 04:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:06 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 0x1793410>, '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 0x1794310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17947a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:22:06 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 04:22:06 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 04:22:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:22:06 INFO - Return code: 0 04:22:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:22:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:22:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:22:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:22:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:22:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:22:07 INFO - Return code: 0 04:22:07 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/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 04:22:07 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/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 04:22:07 INFO - Using env: {'DISPLAY': ':0', 04:22:07 INFO - 'HOME': '/home/cltbld', 04:22:07 INFO - 'LANG': 'en_US.UTF-8', 04:22:07 INFO - 'LANGUAGE': 'en_US:en', 04:22:07 INFO - 'LOGNAME': 'cltbld', 04:22:07 INFO - 'MAIL': '/var/mail/cltbld', 04:22:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:22:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:07 INFO - 'MOZ_NO_REMOTE': '1', 04:22:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:07 INFO - 'NO_EM_RESTART': '1', 04:22:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:07 INFO - 'PWD': '/builds/slave/test', 04:22:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:22:07 INFO - 'SHELL': '/bin/bash', 04:22:07 INFO - 'SHLVL': '1', 04:22:07 INFO - 'TERM': 'linux', 04:22:07 INFO - 'TMOUT': '86400', 04:22:07 INFO - 'USER': 'cltbld', 04:22:07 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060', 04:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:07 INFO - '_': '/tools/buildbot/bin/python'} 04:22:07 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/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 04:22:08 INFO - mozversion application_buildid: 20160506013623 04:22:08 INFO - mozversion application_changeset: b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f 04:22:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:22:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:22:08 INFO - mozversion application_name: Firefox 04:22:08 INFO - mozversion application_remotingname: firefox-dev 04:22:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:22:08 INFO - mozversion application_vendor: Mozilla 04:22:08 INFO - mozversion application_version: 48.0a2 04:22:08 INFO - mozversion platform_buildid: 20160506013623 04:22:08 INFO - mozversion platform_changeset: b61ad3a6049cbcfe4945897e94b8d7ce5beb5c5f 04:22:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:22:08 INFO - mozversion platform_version: 48.0a2 04:22:08 INFO - using testdate: 1462533728 04:22:08 INFO - actual date: 1462533728 04:22:08 INFO - starting webserver on 'localhost:39283' 04:22:08 INFO - SUITE-START | Running 2 tests 04:22:08 INFO - TEST-START | dromaeo_css 04:22:08 INFO - operating with platform_type : linux_ 04:22:08 INFO - Initialising browser for dromaeo_css test... 04:22:08 INFO - TEST-INFO | started process 20579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0VAVwJ/profile http://localhost:39283/getInfo.html) 04:22:12 INFO - PROCESS | 20579 | __metrics Screen width/height:1600/1200 04:22:12 INFO - PROCESS | 20579 | colorDepth:24 04:22:12 INFO - PROCESS | 20579 | Browser inner width/height: 1024/697 04:22:12 INFO - PROCESS | 20579 | __metrics 04:22:13 ERROR - PROCESS | 20579 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:22:13 INFO - TEST-INFO | 20579: exit 0 04:22:13 INFO - Browser initialized. 04:22:13 INFO - Running cycle 1/1 for dromaeo_css test... 04:22:13 INFO - TEST-INFO | started process 20671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0VAVwJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:22:25 INFO - PROCESS | 20671 | RSS: Main: 142012416 04:22:25 INFO - PROCESS | 20671 | 04:23:16 INFO - PROCESS | 20671 | 1462533796703 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] 04:25:24 INFO - PROCESS | 20671 | Cycle 1(1): loaded http://localhost:39283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39283/tests/dromaeo/cssquery-ext.html) 04:25:25 INFO - PROCESS | 20671 | RSS: Main: 250445824 04:25:25 INFO - PROCESS | 20671 | 04:28:27 INFO - PROCESS | 20671 | Cycle 1(1): loaded http://localhost:39283/tests/dromaeo/cssquery-ext.html (next: http://localhost:39283/tests/dromaeo/cssquery-jquery.html) 04:28:28 INFO - PROCESS | 20671 | RSS: Main: 219262976 04:28:28 INFO - PROCESS | 20671 | 04:31:29 INFO - PROCESS | 20671 | Cycle 1(1): loaded http://localhost:39283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39283/tests/dromaeo/cssquery-mootools.html) 04:31:30 INFO - PROCESS | 20671 | RSS: Main: 220143616 04:31:30 INFO - PROCESS | 20671 | 04:34:32 INFO - PROCESS | 20671 | Cycle 1(1): loaded http://localhost:39283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39283/tests/dromaeo/cssquery-prototype.html) 04:34:32 INFO - PROCESS | 20671 | RSS: Main: 221040640 04:34:32 INFO - PROCESS | 20671 | 04:37:35 INFO - PROCESS | 20671 | Cycle 1(1): loaded http://localhost:39283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39283/tests/dromaeo/cssquery-yui.html) 04:37:35 INFO - PROCESS | 20671 | RSS: Main: 213196800 04:37:35 INFO - PROCESS | 20671 | 04:40:38 INFO - PROCESS | 20671 | Cycle 1(1): loaded http://localhost:39283/tests/dromaeo/cssquery-yui.html (next: http://localhost:39283/tests/dromaeo/cssquery-dojo.html) 04:40:38 INFO - PROCESS | 20671 | RSS: Main: 250732544 04:40:38 INFO - PROCESS | 20671 | 04:40:38 INFO - PROCESS | 20671 | __start_tp_report 04:40:38 INFO - PROCESS | 20671 | _x_x_mozilla_page_load 04:40:38 INFO - PROCESS | 20671 | _x_x_mozilla_page_load_details 04:40:38 INFO - PROCESS | 20671 | |i|pagename|runs| 04:40:38 INFO - PROCESS | 20671 | |0;dojo.html;3286.9999999999995;3311.437055700531;3332.1836150143213;3333.333333333334;3345.180430794456;5429.429909859462;5456.8090116845915;5462.453754624546;5467.0705979983395;5483.7806487740445;5474.151506516487;5478.123500239963;5486.231927530139;5488.890222195554;5515.7242137893045;4948.7773050212645;4966.850994470163;5011.14810482217;5028.572571331423;5092.9236061459105;4988.950110498885;5022.59819214462;5031.723255220962;5035.471275516073;5037.420696619881;5029.9748501257445;5100.566451851597;5103.055934652083;5124.4875512448825;5133.948660513403;5133.84598462043;5136.845894623168;5152.124138896396;5154.536091751723;5162.199859021839;4974.900501989976;5021.698698078127;5067.898642027176;5103.693778373309;5112.897742045176;5469.316335458067;5504.146857237135;5505.559555235572;5510.779568817243;5516.420775818561;5931.317898441691;5938;5938.049912014057;5943.524518038546;5946;5967.850803729898;5986.700664966777;6037.879242415171;6040.275166979946;6073.967425537669;5573.386927437979;5622.97188514063;5625.718714064321;5630.71846407678;5632.633878797865;5874.853128671732;6085.8478538036015;6089.086637004396;6089.665068421191;6141.969290153521;5823.505002074787;5921.467067963904;5933.228680271537;5936.7328470218945;5941.435563621449;5936.881262374728;5937.851553711105;5939.584229104008;5943.910841337383;5944.821655350346;5811.854703632443;5859.794907178229;5907.084401917709;5908.645481271137;5912.704364781744;5994.310654274727;6002.819915402545;6007.128966299862;6007.849803754941;6045.3652366501765;4534.070515544371;4551.38556294896;4557.225271703818;4557.863264102082;4575.313702944585;3989.880303590897;4009.498812648419;4046.473958385391;4060.3300455425115;4096.631303182728;5674.744636491368;5696.458836410535;5698.487136157766;5702.0591602385975;5719.828405147852;6010.729517171738;6033.215681961317;6034;6040.214772079602;6045.093236014633;5579.888402231933;5618.690971996498;5646.71766411686;5706.229658995982;5706.971465142731;5081.212412076134;5117.8464646060675;5118.8976220476125;5124.948750512447;5149.0474262261605;6186.412290832363;6204.937950620436;6216.378362163748;6227.190465239581;6227.346128656516;5794.942050579441;5992.790252341147;6037.577369584087;6067.180930574493;6074.119252708421;6185.072239164161;6203.627782333075;6222.377762223741;6229.657368844576;6236.126942228001;5685.175649530877;5889.204957330877;5893.233879595625;5899.321578018583;5919.31927828288;5915.911261330997;5924.111383292368;5970.552208584287;5981.222441082631;6018.187544681412;5751.4536119068625;5779.219805326227;5779.971100144472;5784.305883293863;5789.2763404574425;5654;5680.971595141998;5740.3685594585395;5741.224934633938;5757.568182386254;5549.750261238173;5554.527865131509;5565.916511252415;5573.359063707726;5581.7209139543675;5670.121131224667;5674.971625142013;5683.77264909399;5686.175504551734;5707.571932105192;5590.636608620427;5592.161175823659;5646.407127251579;5649.20911072442;5708.571857110816 04:40:38 INFO - PROCESS | 20671 | |1;ext.html;651.8077167235665;667.7762949411947;679.7043286170515;712.3909057755619;716.4877112864301;33992.4901126483;35003.82498087509;35010.64989350106;35088.298234035334;40484;44097.55902440983;44285.557144428545;44486;44523;44594;8787.64849406023;8972.057933916944;8977;8980.012198658142;8980.506072166028;8434.53610051447;8649.913500864974;8794.912050879473;10775.245732798707;11060.336379817196;10673.306235094733;10745.194110441747;10745.301555398913;10765.461726913662;10767.515461804198;8380.120087390796;10601.575936962512;10672.30630009047;10672.573097076107;10680.305780124267;10301.845472317922;10426;10454.059134677915;10464.215183861164;10493.108085812715;41458;41688.79155604233;41756.37365439521;41790.58209417928;41852.162956741;3618.3848745713294;3653.9086522836874;3703.518542589473;3772.6981841452616;3833.9041523961846;31610.841945790125;31949.680503194904;33109;34609.82695086534;34888.12779680503;4574.542545745432;4583.427071616048;4588.311753237042;4597.770111494412;4684.688287279567;311245;316022;316621.9999999977;317015;317336;41104.1779164421;66686.66656666686;67733.32266677369;67737.5970561912;67786;40518.79740601278;40612;40824.59175408267;40872.59127408747;40953.79523102365;17229;17542.91228543849;17549.0348030857;17598.12009399525;17606.82393176052;13060.738785224243;13596.524121655695;13597.660058498617;13609.795853062213;14919.328630211667;9399.389039712534;9466.29002824791;9487.620495180254;9517.333786635008;9531.761705957406;3177.189816596753;3184.50640150777;3236.9838150809096;3258.6741325867224;3316.5522654441825;1049.1030169205371;1204.7951848185653;1270.7522033203622;1277.6997405609675;1281.4810001949224;34033.48949765755;34124.08941472739;34330.82834585811;34585.48121778175;34608.82695586506;1239.2378687107544;1245.5017992802952;1261.2684642907093;1332.9666758331118;1342.1209108034254;18052.368167114088;18215.72676409855;18267.451976440727;18297.90851045763;18341.90829045873;472669;477707;479061;480960;482478;64066.67966660137;64812.67593662001;64880;64949.67525162439;65010.34989650043;1338.9933050334687;1486.613480495079;1545.822230443491;1547.0562956596468;1626.8129165145922;30659.693403065685;31548.684513154574;31569.68430315759;31930.20174495656;32636;47770.52229477661;48124.75937620289;48188.5181148198;48196.7590162047;48244.27633585569;297348;303425;304148;304518;304862;28641.14076577706;31271.01714251495;31358.686413135576;32388;32414;49976;50737.49262507475;50858.49141508686;50912.23631645602;51904.48095518997;41793;42012.789936050125;42138;42405.1518969625;43545;40635.796821015705;40759.796201018806;41129.38305925354;42570.14859702727;42627;43347.34978975381;44038.55961440344;44489.11021779611;44650.55349446594;44861.77569112134;34499.65500345065;37570.8121459391;37643.247135057696;37904;38155.618443815205;29391.706082939752;29501.704982949897;29535.85232073826;29891.252718682208;30057.248568785082 04:40:38 INFO - PROCESS | 20671 | |2;jquery.html;426.2391630938774;428.539320230752;435.70589851850013;437.22174529337775;441.15959097918477;17231.569210769736;18071.63856722865;18744.531386715324;18752.90623546882;19080.33218837341;18275.36036238732;18469.35357262496;18545.536361590934;19268.80731192691;19285;5638.971805140968;5677.17680936264;5904.409559044083;5905.468507834294;5932.37710040446;5871.383504731984;5891.234139561851;5901.586888917777;5904.350521442638;5912.733926973297;5783.5084017858535;5896.557758168155;5897.439743224387;6395.072714456401;6448.742050317982;6279.780207692755;6309.242890853127;6374.17135772349;6417.454516366114;6418.42234198922;5754.625949313281;5763.884722305573;5899.646021238696;5959.374265702082;5965.403459654043;13985.650358741012;14231;14231.857681423156;15992.92003539975;23597.29208123759;2423.6849209602815;2447.351451865239;2561.9615705764427;2569.678790151231;3024.123004328742;10344.431056291902;10345.844812327821;10662.466876656214;10670.73323166927;10872;1805.810389909067;1840.7975122736489;1946.9805301947083;2165.372042107787;2237.697910782056;81028.59485702592;82068.9999999994;82915;83313.58343208306;87436;11209.887901121048;11301.49143288554;11344.943275283571;11594.71013224676;11765.411729413496;16173;16272.18639068042;16371.918140409221;16411.91794041046;16412.917935410245;9159.542022898962;9185.402948808307;9186.448813071238;9208.171264586219;9250.259979201783;9136.908630913606;9155.313351498664;9172.220361269367;9198.49408282551;9231.399959002643;5010.949890501121;5027.2207807789855;5047.167217409086;5050.116229659869;5085.1355269604255;1999.5201151723481;2023.7267968824315;2053.035073515445;2074.647309957311;2077.1483691686335;1029.9975571209839;1124.859392575928;1127.5546159267044;1128.4132251229314;1153.988460115388;18499.260029598936;19406.2237510498;19613.80386196148;20243.493912652302;20996.47508812292;1040.5837664933936;1059.0468578279456;1059.8251288537306;1154.8325492803665;1171.9296842189497;10757;11139.554417823196;11170.776584468265;11175.273607215506;11230.55077796879;537175;539827;554363;556357;556466;90452;93072.53463732637;94691.52654236685;94973.05026949642;95339.52330238304;1122.3434290939892;1141.9771604567861;1173.5531416995489;1194.5580135349976;1214.7388311513066;17155.70243996842;17556.912215438842;17671;17672.38146664912;17781.19984600722;41825.163496729285;41991.7900410496;42460.363094554225;42721;42889.57110428856;58931.410685894305;60076.69961650164;60122.39877601168;60465.69767151136;60470.09294860493;9148.130927561871;9233.769155771159;9249.352545322032;9425.57584908667;9507.096825801538;13331.466741330238;13780.65548361299;13865.376058077612;14202.28988550589;14242.928785356007;12292.754144917231;12341.457317835271;12372.505099796268;12649.557265495663;12720.618381448572;12006.279623222634;12222.633321000385;12274.38628068575;12308.507659693512;12422.06834487399;12086.576969806014;12526.874731252936;12653.87346126527;12759.553415630407;12791.232526048467;8949.642014319354;9068.274538036809;9110.225630821455;9284.628614855601;9372.81254374895;12142.635720928387;12442.253464792142;12442.75114497723;12521.248725076524;12570.43433045497 04:40:38 INFO - PROCESS | 20671 | |3;mootools.html;1420.4957240179729;1558.2754019380989;1570.1050401271277;1725.318499192818;1834.6972749496333;7617.162112167664;8211.425200235986;8273.586320683964;8276.875846862287;8293.626786794593;8172.264496195341;8325.209105135018;8346.248837604615;8370.288525475342;8375.246227839492;2117.0473287020827;2365.60967440373;2411.5297516984238;2417.2144053182697;2431.6474111253856;2421.0315873650507;2430.1980346485707;2432.391902024494;2433.9269821905373;2434.3548959525738;2317.6639387288833;2393.5811233034237;2398.7361390247147;2401.399650087478;2405.3625789165885;2135.348718640814;2281.954360912781;2303.7120359955006;2318.258157389636;2322.512272422793;2193.670949357593;2216.556688662274;2229.885057471264;2232.877191754469;2256.187772401934;8192.18078192182;8252.092269850311;8254.05078415978;8259.752207433727;8262.132476089984;5197.974010129963;5279.868003299948;5353.357597088374;5361.919571206435;5398.6220964532495;3453.637368076341;3504.7721898076798;3521.6126226115107;3533.152043509565;3582.946255806165;1110.6057349640923;1136.79537683217;1160.3154139057913;1176.6587689570015;1203.7652657731746;12203.816942745865;12214.145009849313;12241.20432171915;12256;12294.938525307316;4851.58761505276;4858.73276969763;4878.56092951636;4906.779194936236;4937.5556199942175;10359.430231337197;10365.9481702591;10374.118199952938;10377.792444151226;10382.792344153075;4932.654714170046;5589.496945274945;5593.3847276799515;5594.776208951596;5603.943960560424;4852.223644216909;4861.052094841542;4877.878053048631;4880.097182021337;4909.754512274443;4051.554329023805;4084.6119618636776;4123.2165888481095;4161.771102589326;4163.666906647461;1297.0920355751011;1305.549585393038;1307.4443361571293;1311.672081979505;1325.204877073748;850.4472093139385;925.6898938855425;966.8984756600596;975.2198241406846;1014.1379827146866;5723.084306511021;5745.195672605839;5746.42535746422;5871.853203669943;5992.40075992406;444.07410549005687;445.3920398655811;449.69870186974805;451.4289423878796;467.89940162865145;3779.508663873734;3812.599677033927;3814.3706288462095;3833.4441505981476;3859.073822282632;10221.591136354611;10624.043836054792;10647.094996925349;10703.571857125784;10731;10275.74310642225;10496.212784041227;10516.26386152962;10629.149668026539;10657.680269591925;8106.351491880518;8154.14381489935;8160;8192.426530142951;8279.8344033119;5475.425080366664;5488.286522752017;5547.750351234285;5602.411746766694;5692.743826527733;9045.321600879828;9503.144716975505;9675.564599592895;9681.419114853132;9721.756956076155;9421.340506164503;9633.181179599533;9676.85484717744;9851.852222216528;9856.063673950963;6845.760398386033;7037.592481503617;7151.570905745672;7627.809304767426;7713.730019449293;7950.840983180188;7967.721129760431;7996.84006319882;8018.3585313173635;8047.155048720034;7012.7545535906;7148;7222.277772222736;7275.090613673291;7376.151742549676;7279.308465695751;7329.450291228072;7335.926640733524;7459.813504662427;7477.588732619758;7073.6463176839925;7081.858362832818;7121.537100088478;7123.501354905314;7152.570845749272;4790.688605240648;4795.976020120017;4836.854894353175;4873.171560834738;4888.462269150319;4995.25071239317;4995.825146119869;5005.724685142352;5008.57427118699;5072.391313042459 04:40:38 INFO - PROCESS | 20671 | |4;prototype.html;356.525820658524;359.62598897146967;363.2897685025775;363.71811845819497;366.5107082045469;6288.528360372973;6345.175127233459;6353.174087368647;6373.776917807866;6407.231132264129;6297.433231009209;6372.426481616653;6373.521985851056;6377.968110159442;6387.137736405584;4625.098105869349;4667.13657973276;4817.253325734499;4845.248986407112;4847.757612119398;4812.663113582051;4815.879603009936;4844.346013288214;4862.659613827033;4867.634927380443;4594.104149690795;4814.253790662453;4818.831340903069;4819.493953134923;4826.782794774226;4644.094401591691;4677.134730074947;4712.246040633499;4750.596199323062;4764.475907650156;4211.494620645542;4218.683598730107;4220.198162349144;4239.342901850187;4244.681648876347;6029.638221706711;6042.486388656969;6047.183630209909;6049.909251361233;6056.636601803862;5581.469760372758;5584.5253153482;5592.5246354059955;5595.692236926968;5602.943970560283;6460.96624540076;6590.044443555657;6593.703283352213;6601.867962640768;6604.405603495708;4694.671373003891;4699.060187962421;4699.201135806921;4703.17694403478;4714.1985862403135;6839.829004274883;6864.897026544606;6886.827829304258;6899.482538809559;6918.481113916426;4775.116603428377;4812.1578723723205;4812.951870481321;4815.181419158752;4818.951810481921;4865.854024379274;4873.805047798049;4875.609951203895;4877.829275975324;4883.975580122076;5572.247746554163;5572.582056345709;5574.637648552913;5583.497485226268;5594.356648985418;6431.517636177306;6638.269790323061;6651.767188148391;6655.767048153291;6672.532922695462;1675.6397374564283;1724.5860993361503;1724.7067998440295;1727.5422013166522;1727.576743697777;1082.5128692088592;1143.0741099709262;1150.9482073306554;1157.2073129906041;1167.53882216524;6320.747170113144;6476.740930362827;6500.739970401131;6530.314316996742;6537;6883.621400822903;6901.309869013159;6903.6203008835;6906.033155358254;6926.341997510229;6489.0266460030425;6493.610383377012;6504.121943537656;6504.902426463606;6512.088307636935;3694.2057457646733;3737.121776382548;3737.177820879402;3746.306933217309;3751.306008388457;7075.4903903309305;7128.893066604005;7181.964090179516;7216.422686185093;7223.349898509159;6946.305369463114;6968.407685346701;7006.299370063055;7030.332118448841;7036.437085033185;7086;7117.786466406016;7151.463640227003;7158.427325813923;7175.605341706152;6868.450523957971;6872.037914692047;6875.759348422981;6891;6906.896396554156;6626.469882409492;6820.590764554143;6838.0084887692;6878.931210688029;6884.8967265490055;7176.928230717626;7224.277572242734;7241.927580724126;7251.782446526613;7257.891131632924;4700.083483720641;4736.313234581035;4751.073540659539;4751.168545504592;4758.619310455086;6938.271481494572;6940.861182776417;6946.235914049552;6948.826279343057;6954.860902782018;6543.985682219263;6763.2222294434805;6766.458683305422;6788.626625535446;6791.422729068085;6684.7326106957125;6715.93284067153;6729.5625784323865;6734.8653026940165;6737.797866064026;6601.735930562723;6616.801495955129;6618.801435956929;6618.867622647616;6621.33786621334;6768.96615516939;6771.762988295583;6797.966010170116;6802.081718967876;6851.760188393581;6468.062130991074;6599.472042236705;6608.7026083825385;6618.2719900811835;6629.7348106075215 04:40:38 INFO - PROCESS | 20671 | |5;yui.html;904.073324842037;904.4528060523385;916.408916249019;923.4551614547415;931.329442801183;14476.63808404789;14771.926140369284;14785.926070369633;14819.925900370497;14823.555293341204;13232.13991090581;14690.779638305434;14716.85283147171;14734.115953042798;14749.188794616291;882.567541904467;893.678275820704;895.1093661806511;899.9865002024975;902.467544148952;835.7325655790149;883.2889523933231;889.8353804546148;889.8531742262519;893.8391089603869;902.62992173209;933.3186773655236;935.7473482159813;936.1761649748246;941.6845356805478;898.6091050393068;927.3832901120746;930.5812384427035;930.8929473110611;934.1032608695592;656.4780999105723;669.0299066353806;678.0879716780922;681.3901558105517;682.0349205873683;13726.313684315744;13907.165570065828;13913.095648782797;13925.721485570333;13953.302334883216;13274.269915154662;13285;13291.800622990662;13320.666983325398;13325.800112998313;10816.134709223243;11094.44527773608;11110.833337499864;11132.220744547885;11165.72085697856;3899.492103801279;3927.175293188434;3948.506436695413;3965.6232657897453;3981.064449854282;50705.23942140871;50973.745131274474;53206.73396632992;58311.416885831444;58622.70688646572;11965.46155423008;11970.940145299217;12092;12122.27266364021;12408.379581020912;20600.072996715186;20676.276330328365;20715.4821129473;20724.792752072586;20813.479663008548;8880.955595221982;8946.194842464209;9112.544372781467;9177.862332065024;9318.813623727487;4734.342979956988;4845.152098382769;4908.2637604358915;4936.506349365035;5024.221245706921;3665.7617254878883;3691.557013158438;3697.6302369762807;3701.722370822199;3734.3091528067393;655.4788942790493;672.6098862659645;676.7496026470237;680.9489288303298;690.526989012528;672.6233309346782;682.8770821252123;686.7287421468492;692.7609974558769;726.8001299642535;9243.39917905334;9637.903620963842;9693.369930954465;9784.119429251401;9791.510424478747;710.6801939127309;713.8500914807948;714.2322003845886;721.9099160268033;731.4806487393904;4264.7654379009455;4299.484061912591;4411.316245981878;4435.866923992286;4567.862964111082;62469.68765156145;62584;63418;65220;65311.34688653148;51745.48254517482;52102;52265.47734522682;52513.2123018155;55309;46966;50671.746641267295;51023;51418.228726569134;51815.96368072618;9207.447553146565;9352.205062569758;9519.714408567754;9589.568469419033;9593.616255349707;37949.241015180094;38213;38609.613903860605;38830.223395531364;39443.80278098706;48106.27840582324;49127.75436122796;50245.49754502408;50570;51071;12236.26582405023;12759;13009.739805204032;13082.607521774362;13388.19670819754;14099.929500352433;14225.644358890697;14298;14518.20149891766;14900.0314979526;13506;13522.459101635824;13603.659908501972;13701.246431446367;13732.45070197181;13053.608391747883;13471.057026008086;13490.258035808125;13568.118072325267;13712.588622341345;13256.53602123921;13652.453901844212;13698.246596437291;13729.107608005448;13749.725005499635;11086.944565277123;11173.441327933408;11272.830907536558;11384.48769805344;11540.24988375753;10991.61529346469;11311.208215424842;11367.147463940402;11433.142514311294;11568.24806387582 04:40:38 INFO - PROCESS | 20671 | __end_tp_report 04:40:38 INFO - PROCESS | 20671 | __start_cc_report 04:40:38 INFO - PROCESS | 20671 | _x_x_mozilla_cycle_collect,839 04:40:38 INFO - PROCESS | 20671 | __end_cc_report 04:40:38 INFO - PROCESS | 20671 | __startTimestamp1462534838386__endTimestamp 04:40:38 INFO - PROCESS | 20671 | 04:40:38 INFO - PROCESS | 20671 | ------- Summary: start ------- 04:40:38 INFO - PROCESS | 20671 | Number of tests: 6 04:40:38 INFO - PROCESS | 20671 | 04:40:38 INFO - PROCESS | 20671 | [#0] dojo.html Cycles:165 Average:5521.22 Median:5683.77 stddev:619.51 (10.9%) stddev-sans-first:596.10 04:40:38 INFO - PROCESS | 20671 | Values: 3287.0 3311.4 3332.2 3333.3 3345.2 5429.4 5456.8 5462.5 5467.1 5483.8 5474.2 5478.1 5486.2 5488.9 5515.7 4948.8 4966.9 5011.1 5028.6 5092.9 4989.0 5022.6 5031.7 5035.5 5037.4 5030.0 5100.6 5103.1 5124.5 5133.9 5133.8 5136.8 5152.1 5154.5 5162.2 4974.9 5021.7 5067.9 5103.7 5112.9 5469.3 5504.1 5505.6 5510.8 5516.4 5931.3 5938.0 5938.0 5943.5 5946.0 5967.9 5986.7 6037.9 6040.3 6074.0 5573.4 5623.0 5625.7 5630.7 5632.6 5874.9 6085.8 6089.1 6089.7 6142.0 5823.5 5921.5 5933.2 5936.7 5941.4 5936.9 5937.9 5939.6 5943.9 5944.8 5811.9 5859.8 5907.1 5908.6 5912.7 5994.3 6002.8 6007.1 6007.8 6045.4 4534.1 4551.4 4557.2 4557.9 4575.3 3989.9 4009.5 4046.5 4060.3 4096.6 5674.7 5696.5 5698.5 5702.1 5719.8 6010.7 6033.2 6034.0 6040.2 6045.1 5579.9 5618.7 5646.7 5706.2 5707.0 5081.2 5117.8 5118.9 5124.9 5149.0 6186.4 6204.9 6216.4 6227.2 6227.3 5794.9 5992.8 6037.6 6067.2 6074.1 6185.1 6203.6 6222.4 6229.7 6236.1 5685.2 5889.2 5893.2 5899.3 5919.3 5915.9 5924.1 5970.6 5981.2 6018.2 5751.5 5779.2 5780.0 5784.3 5789.3 5654.0 5681.0 5740.4 5741.2 5757.6 5549.8 5554.5 5565.9 5573.4 5581.7 5670.1 5675.0 5683.8 5686.2 5707.6 5590.6 5592.2 5646.4 5649.2 5708.6 04:40:38 INFO - PROCESS | 20671 | 04:40:38 INFO - PROCESS | 20671 | [#1] ext.html Cycles:180 Average:53787.88 Median:19353.34 stddev:98804.29 (510.5%) stddev-sans-first:99000.91 04:40:38 INFO - PROCESS | 20671 | Values: 651.8 667.8 679.7 712.4 716.5 33992.5 35003.8 35010.6 35088.3 40484.0 44097.6 44285.6 44486.0 44523.0 44594.0 8787.6 8972.1 8977.0 8980.0 8980.5 8434.5 8649.9 8794.9 10775.2 11060.3 10673.3 10745.2 10745.3 10765.5 10767.5 8380.1 10601.6 10672.3 10672.6 10680.3 10301.8 10426.0 10454.1 10464.2 10493.1 41458.0 41688.8 41756.4 41790.6 41852.2 3618.4 3653.9 3703.5 3772.7 3833.9 31610.8 31949.7 33109.0 34609.8 34888.1 4574.5 4583.4 4588.3 4597.8 4684.7 311245.0 316022.0 316622.0 317015.0 317336.0 41104.2 66686.7 67733.3 67737.6 67786.0 40518.8 40612.0 40824.6 40872.6 40953.8 17229.0 17542.9 17549.0 17598.1 17606.8 13060.7 13596.5 13597.7 13609.8 14919.3 9399.4 9466.3 9487.6 9517.3 9531.8 3177.2 3184.5 3237.0 3258.7 3316.6 1049.1 1204.8 1270.8 1277.7 1281.5 34033.5 34124.1 34330.8 34585.5 34608.8 1239.2 1245.5 1261.3 1333.0 1342.1 18052.4 18215.7 18267.5 18297.9 18341.9 472669.0 477707.0 479061.0 480960.0 482478.0 64066.7 64812.7 64880.0 64949.7 65010.3 1339.0 1486.6 1545.8 1547.1 1626.8 30659.7 31548.7 31569.7 31930.2 32636.0 47770.5 48124.8 48188.5 48196.8 48244.3 297348.0 303425.0 304148.0 304518.0 304862.0 28641.1 31271.0 31358.7 32388.0 32414.0 49976.0 50737.5 50858.5 50912.2 51904.5 41793.0 42012.8 42138.0 42405.2 43545.0 40635.8 40759.8 41129.4 42570.1 42627.0 43347.3 44038.6 44489.1 44650.6 44861.8 34499.7 37570.8 37643.2 37904.0 38155.6 29391.7 29501.7 29535.9 29891.3 30057.2 04:40:38 INFO - PROCESS | 20671 | 04:40:38 INFO - PROCESS | 20671 | [#2] jquery.html Cycles:180 Average:30960.37 Median:11536.81 stddev:90251.47 (782.3%) stddev-sans-first:90475.53 04:40:38 INFO - PROCESS | 20671 | Values: 426.2 428.5 435.7 437.2 441.2 17231.6 18071.6 18744.5 18752.9 19080.3 18275.4 18469.4 18545.5 19268.8 19285.0 5639.0 5677.2 5904.4 5905.5 5932.4 5871.4 5891.2 5901.6 5904.4 5912.7 5783.5 5896.6 5897.4 6395.1 6448.7 6279.8 6309.2 6374.2 6417.5 6418.4 5754.6 5763.9 5899.6 5959.4 5965.4 13985.7 14231.0 14231.9 15992.9 23597.3 2423.7 2447.4 2562.0 2569.7 3024.1 10344.4 10345.8 10662.5 10670.7 10872.0 1805.8 1840.8 1947.0 2165.4 2237.7 81028.6 82069.0 82915.0 83313.6 87436.0 11209.9 11301.5 11344.9 11594.7 11765.4 16173.0 16272.2 16371.9 16411.9 16412.9 9159.5 9185.4 9186.4 9208.2 9250.3 9136.9 9155.3 9172.2 9198.5 9231.4 5010.9 5027.2 5047.2 5050.1 5085.1 1999.5 2023.7 2053.0 2074.6 2077.1 1030.0 1124.9 1127.6 1128.4 1154.0 18499.3 19406.2 19613.8 20243.5 20996.5 1040.6 1059.0 1059.8 1154.8 1171.9 10757.0 11139.6 11170.8 11175.3 11230.6 537175.0 539827.0 554363.0 556357.0 556466.0 90452.0 93072.5 94691.5 94973.1 95339.5 1122.3 1142.0 1173.6 1194.6 1214.7 17155.7 17556.9 17671.0 17672.4 17781.2 41825.2 41991.8 42460.4 42721.0 42889.6 58931.4 60076.7 60122.4 60465.7 60470.1 9148.1 9233.8 9249.4 9425.6 9507.1 13331.5 13780.7 13865.4 14202.3 14242.9 12292.8 12341.5 12372.5 12649.6 12720.6 12006.3 12222.6 12274.4 12308.5 12422.1 12086.6 12526.9 12653.9 12759.6 12791.2 8949.6 9068.3 9110.2 9284.6 9372.8 12142.6 12442.3 12442.8 12521.2 12570.4 04:40:38 INFO - PROCESS | 20671 | 04:40:38 INFO - PROCESS | 20671 | [#3] mootools.html Cycles:180 Average:5642.93 Median:4879.33 stddev:3170.35 (65.0%) stddev-sans-first:3163.36 04:40:38 INFO - PROCESS | 20671 | Values: 1420.5 1558.3 1570.1 1725.3 1834.7 7617.2 8211.4 8273.6 8276.9 8293.6 8172.3 8325.2 8346.2 8370.3 8375.2 2117.0 2365.6 2411.5 2417.2 2431.6 2421.0 2430.2 2432.4 2433.9 2434.4 2317.7 2393.6 2398.7 2401.4 2405.4 2135.3 2282.0 2303.7 2318.3 2322.5 2193.7 2216.6 2229.9 2232.9 2256.2 8192.2 8252.1 8254.1 8259.8 8262.1 5198.0 5279.9 5353.4 5361.9 5398.6 3453.6 3504.8 3521.6 3533.2 3582.9 1110.6 1136.8 1160.3 1176.7 1203.8 12203.8 12214.1 12241.2 12256.0 12294.9 4851.6 4858.7 4878.6 4906.8 4937.6 10359.4 10365.9 10374.1 10377.8 10382.8 4932.7 5589.5 5593.4 5594.8 5603.9 4852.2 4861.1 4877.9 4880.1 4909.8 4051.6 4084.6 4123.2 4161.8 4163.7 1297.1 1305.5 1307.4 1311.7 1325.2 850.4 925.7 966.9 975.2 1014.1 5723.1 5745.2 5746.4 5871.9 5992.4 444.1 445.4 449.7 451.4 467.9 3779.5 3812.6 3814.4 3833.4 3859.1 10221.6 10624.0 10647.1 10703.6 10731.0 10275.7 10496.2 10516.3 10629.1 10657.7 8106.4 8154.1 8160.0 8192.4 8279.8 5475.4 5488.3 5547.8 5602.4 5692.7 9045.3 9503.1 9675.6 9681.4 9721.8 9421.3 9633.2 9676.9 9851.9 9856.1 6845.8 7037.6 7151.6 7627.8 7713.7 7950.8 7967.7 7996.8 8018.4 8047.2 7012.8 7148.0 7222.3 7275.1 7376.2 7279.3 7329.5 7335.9 7459.8 7477.6 7073.6 7081.9 7121.5 7123.5 7152.6 4790.7 4796.0 4836.9 4873.2 4888.5 4995.3 4995.8 5005.7 5008.6 5072.4 04:40:38 INFO - PROCESS | 20671 | 04:40:38 INFO - PROCESS | 20671 | [#4] prototype.html Cycles:180 Average:5607.75 Median:6419.37 stddev:1686.74 (26.3%) stddev-sans-first:1644.77 04:40:38 INFO - PROCESS | 20671 | Values: 356.5 359.6 363.3 363.7 366.5 6288.5 6345.2 6353.2 6373.8 6407.2 6297.4 6372.4 6373.5 6378.0 6387.1 4625.1 4667.1 4817.3 4845.2 4847.8 4812.7 4815.9 4844.3 4862.7 4867.6 4594.1 4814.3 4818.8 4819.5 4826.8 4644.1 4677.1 4712.2 4750.6 4764.5 4211.5 4218.7 4220.2 4239.3 4244.7 6029.6 6042.5 6047.2 6049.9 6056.6 5581.5 5584.5 5592.5 5595.7 5602.9 6461.0 6590.0 6593.7 6601.9 6604.4 4694.7 4699.1 4699.2 4703.2 4714.2 6839.8 6864.9 6886.8 6899.5 6918.5 4775.1 4812.2 4813.0 4815.2 4819.0 4865.9 4873.8 4875.6 4877.8 4884.0 5572.2 5572.6 5574.6 5583.5 5594.4 6431.5 6638.3 6651.8 6655.8 6672.5 1675.6 1724.6 1724.7 1727.5 1727.6 1082.5 1143.1 1150.9 1157.2 1167.5 6320.7 6476.7 6500.7 6530.3 6537.0 6883.6 6901.3 6903.6 6906.0 6926.3 6489.0 6493.6 6504.1 6504.9 6512.1 3694.2 3737.1 3737.2 3746.3 3751.3 7075.5 7128.9 7182.0 7216.4 7223.3 6946.3 6968.4 7006.3 7030.3 7036.4 7086.0 7117.8 7151.5 7158.4 7175.6 6868.5 6872.0 6875.8 6891.0 6906.9 6626.5 6820.6 6838.0 6878.9 6884.9 7176.9 7224.3 7241.9 7251.8 7257.9 4700.1 4736.3 4751.1 4751.2 4758.6 6938.3 6940.9 6946.2 6948.8 6954.9 6544.0 6763.2 6766.5 6788.6 6791.4 6684.7 6715.9 6729.6 6734.9 6737.8 6601.7 6616.8 6618.8 6618.9 6621.3 6769.0 6771.8 6798.0 6802.1 6851.8 6468.1 6599.5 6608.7 6618.3 6629.7 04:40:38 INFO - PROCESS | 20671 | 04:40:38 INFO - PROCESS | 20671 | [#5] yui.html Cycles:180 Average:15361.39 Median:25850.17 stddev:17422.44 (67.4%) stddev-sans-first:17437.49 04:40:38 INFO - PROCESS | 20671 | Values: 904.1 904.5 916.4 923.5 931.3 14476.6 14771.9 14785.9 14819.9 14823.6 13232.1 14690.8 14716.9 14734.1 14749.2 882.6 893.7 895.1 900.0 902.5 835.7 883.3 889.8 889.9 893.8 902.6 933.3 935.7 936.2 941.7 898.6 927.4 930.6 930.9 934.1 656.5 669.0 678.1 681.4 682.0 13726.3 13907.2 13913.1 13925.7 13953.3 13274.3 13285.0 13291.8 13320.7 13325.8 10816.1 11094.4 11110.8 11132.2 11165.7 3899.5 3927.2 3948.5 3965.6 3981.1 50705.2 50973.7 53206.7 58311.4 58622.7 11965.5 11970.9 12092.0 12122.3 12408.4 20600.1 20676.3 20715.5 20724.8 20813.5 8881.0 8946.2 9112.5 9177.9 9318.8 4734.3 4845.2 4908.3 4936.5 5024.2 3665.8 3691.6 3697.6 3701.7 3734.3 655.5 672.6 676.7 680.9 690.5 672.6 682.9 686.7 692.8 726.8 9243.4 9637.9 9693.4 9784.1 9791.5 710.7 713.9 714.2 721.9 731.5 4264.8 4299.5 4411.3 4435.9 4567.9 62469.7 62584.0 63418.0 65220.0 65311.3 51745.5 52102.0 52265.5 52513.2 55309.0 46966.0 50671.7 51023.0 51418.2 51816.0 9207.4 9352.2 9519.7 9589.6 9593.6 37949.2 38213.0 38609.6 38830.2 39443.8 48106.3 49127.8 50245.5 50570.0 51071.0 12236.3 12759.0 13009.7 13082.6 13388.2 14099.9 14225.6 14298.0 14518.2 14900.0 13506.0 13522.5 13603.7 13701.2 13732.5 13053.6 13471.1 13490.3 13568.1 13712.6 13256.5 13652.5 13698.2 13729.1 13749.7 11086.9 11173.4 11272.8 11384.5 11540.2 10991.6 11311.2 11367.1 11433.1 11568.2 04:40:38 INFO - PROCESS | 20671 | -------- Summary: end -------- 04:40:38 INFO - PROCESS | 20671 | 04:40:39 INFO - TEST-INFO | 20671: exit 0 04:40:39 INFO - TEST-OK | dromaeo_css | took 1111094ms 04:40:39 INFO - TEST-START | kraken 04:40:39 INFO - operating with platform_type : linux_ 04:40:39 INFO - Initialising browser for kraken test... 04:40:39 INFO - TEST-INFO | started process 20864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ1Cfih/profile http://localhost:39283/getInfo.html) 04:40:42 INFO - PROCESS | 20864 | __metrics Screen width/height:1600/1200 04:40:42 INFO - PROCESS | 20864 | colorDepth:24 04:40:42 INFO - PROCESS | 20864 | Browser inner width/height: 1024/697 04:40:42 INFO - PROCESS | 20864 | __metrics 04:40:43 ERROR - PROCESS | 20864 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:40:44 INFO - TEST-INFO | 20864: exit 0 04:40:44 INFO - Browser initialized. 04:40:44 INFO - Running cycle 1/1 for kraken test... 04:40:44 INFO - TEST-INFO | started process 20951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ1Cfih/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:56 INFO - PROCESS | 20951 | RSS: Main: 141897728 04:40:56 INFO - PROCESS | 20951 | 04:40:58 INFO - PROCESS | 20951 | Cycle 1(1): loaded http://localhost:39283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39283/tests/kraken/driver.html?testName=audio-beat-detection) 04:40:59 INFO - PROCESS | 20951 | RSS: Main: 196485120 04:40:59 INFO - PROCESS | 20951 | 04:41:02 INFO - PROCESS | 20951 | Cycle 1(1): loaded http://localhost:39283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39283/tests/kraken/driver.html?testName=audio-dft) 04:41:03 INFO - PROCESS | 20951 | RSS: Main: 182161408 04:41:03 INFO - PROCESS | 20951 | 04:41:05 INFO - PROCESS | 20951 | Cycle 1(1): loaded http://localhost:39283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39283/tests/kraken/driver.html?testName=audio-fft) 04:41:06 INFO - PROCESS | 20951 | RSS: Main: 273260544 04:41:06 INFO - PROCESS | 20951 | 04:41:08 INFO - PROCESS | 20951 | Cycle 1(1): loaded http://localhost:39283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39283/tests/kraken/driver.html?testName=audio-oscillator) 04:41:09 INFO - PROCESS | 20951 | RSS: Main: 178888704 04:41:09 INFO - PROCESS | 20951 | 04:41:11 INFO - PROCESS | 20951 | Cycle 1(1): loaded http://localhost:39283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:41:11 INFO - PROCESS | 20951 | RSS: Main: 177573888 04:41:11 INFO - PROCESS | 20951 | 04:41:14 INFO - PROCESS | 20951 | Cycle 1(1): loaded http://localhost:39283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39283/tests/kraken/driver.html?testName=imaging-darkroom) 04:41:15 INFO - PROCESS | 20951 | RSS: Main: 212852736 04:41:15 INFO - PROCESS | 20951 | 04:41:18 INFO - PROCESS | 20951 | Cycle 1(1): loaded http://localhost:39283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39283/tests/kraken/driver.html?testName=imaging-desaturate) 04:41:19 INFO - PROCESS | 20951 | RSS: Main: 212299776 04:41:19 INFO - PROCESS | 20951 | 04:41:22 INFO - PROCESS | 20951 | Cycle 1(1): loaded http://localhost:39283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39283/tests/kraken/driver.html?testName=json-parse-financial) 04:41:22 INFO - PROCESS | 20951 | RSS: Main: 212234240 04:41:22 INFO - PROCESS | 20951 | 04:41:24 INFO - PROCESS | 20951 | Cycle 1(1): loaded http://localhost:39283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:41:24 INFO - PROCESS | 20951 | RSS: Main: 192757760 04:41:24 INFO - PROCESS | 20951 | 04:41:26 INFO - PROCESS | 20951 | Cycle 1(1): loaded http://localhost:39283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39283/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:41:27 INFO - PROCESS | 20951 | RSS: Main: 196493312 04:41:27 INFO - PROCESS | 20951 | 04:41:29 INFO - PROCESS | 20951 | Cycle 1(1): loaded http://localhost:39283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:41:29 INFO - PROCESS | 20951 | RSS: Main: 210731008 04:41:29 INFO - PROCESS | 20951 | 04:41:32 INFO - PROCESS | 20951 | Cycle 1(1): loaded http://localhost:39283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:41:32 INFO - PROCESS | 20951 | RSS: Main: 210919424 04:41:32 INFO - PROCESS | 20951 | 04:41:35 INFO - PROCESS | 20951 | Cycle 1(1): loaded http://localhost:39283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:41:36 INFO - PROCESS | 20951 | RSS: Main: 208900096 04:41:36 INFO - PROCESS | 20951 | 04:41:37 INFO - PROCESS | 20951 | Cycle 1(1): loaded http://localhost:39283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39283/tests/kraken/driver.html?testName=ai-astar) 04:41:38 INFO - PROCESS | 20951 | RSS: Main: 273031168 04:41:38 INFO - PROCESS | 20951 | 04:41:38 INFO - PROCESS | 20951 | __start_tp_report 04:41:38 INFO - PROCESS | 20951 | _x_x_mozilla_page_load 04:41:38 INFO - PROCESS | 20951 | _x_x_mozilla_page_load_details 04:41:38 INFO - PROCESS | 20951 | |i|pagename|runs| 04:41:38 INFO - PROCESS | 20951 | |0;ai-astar;112;110;111;110;111;111;105;109;110;107 04:41:38 INFO - PROCESS | 20951 | |1;audio-beat-detection;155;127;150;187;140;156;152;133;182;135 04:41:38 INFO - PROCESS | 20951 | |2;audio-dft;163;162;162;161;162;162;160;161;161;160 04:41:38 INFO - PROCESS | 20951 | |3;audio-fft;76;77;77;168;76;77;76;76;166;76 04:41:38 INFO - PROCESS | 20951 | |4;audio-oscillator;92;92;145;91;91;92;147;93;92;143 04:41:38 INFO - PROCESS | 20951 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;116;116;116 04:41:38 INFO - PROCESS | 20951 | |6;imaging-darkroom;145;145;146;146;145;145;145;146;146;145 04:41:38 INFO - PROCESS | 20951 | |7;imaging-desaturate;94;94;95;95;95;95;95;94;95;95 04:41:38 INFO - PROCESS | 20951 | |8;json-parse-financial;55;59;53;53;54;55;55;83;53;53 04:41:38 INFO - PROCESS | 20951 | |9;json-stringify-tinderbox;57;59;58;57;57;58;57;59;64;57 04:41:38 INFO - PROCESS | 20951 | |10;stanford-crypto-aes;73;71;73;72;73;73;81;73;73;74 04:41:38 INFO - PROCESS | 20951 | |11;stanford-crypto-ccm;114;125;111;113;112;108;112;110;178;134 04:41:38 INFO - PROCESS | 20951 | |12;stanford-crypto-pbkdf2;158;165;164;162;163;174;157;160;155;156 04:41:38 INFO - PROCESS | 20951 | |13;stanford-crypto-sha256-iterative;71;67;67;67;65;66;66;66;68;66 04:41:38 INFO - PROCESS | 20951 | __end_tp_report 04:41:38 INFO - PROCESS | 20951 | __start_cc_report 04:41:38 INFO - PROCESS | 20951 | _x_x_mozilla_cycle_collect,1620 04:41:38 INFO - PROCESS | 20951 | __end_cc_report 04:41:38 INFO - PROCESS | 20951 | __startTimestamp1462534898043__endTimestamp 04:41:38 INFO - PROCESS | 20951 | 04:41:38 INFO - PROCESS | 20951 | ------- Summary: start ------- 04:41:38 INFO - PROCESS | 20951 | Number of tests: 14 04:41:38 INFO - PROCESS | 20951 | 04:41:38 INFO - PROCESS | 20951 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:2.12 (1.9%) stddev-sans-first:2.06 04:41:38 INFO - PROCESS | 20951 | Values: 112.0 110.0 111.0 110.0 111.0 111.0 105.0 109.0 110.0 107.0 04:41:38 INFO - PROCESS | 20951 | 04:41:38 INFO - PROCESS | 20951 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:153.50 stddev:19.92 (13.0%) stddev-sans-first:21.10 04:41:38 INFO - PROCESS | 20951 | Values: 155.0 127.0 150.0 187.0 140.0 156.0 152.0 133.0 182.0 135.0 04:41:38 INFO - PROCESS | 20951 | 04:41:38 INFO - PROCESS | 20951 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:0.83 04:41:38 INFO - PROCESS | 20951 | Values: 163.0 162.0 162.0 161.0 162.0 162.0 160.0 161.0 161.0 160.0 04:41:38 INFO - PROCESS | 20951 | 04:41:38 INFO - PROCESS | 20951 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.00 stddev:38.22 (50.3%) stddev-sans-first:39.94 04:41:38 INFO - PROCESS | 20951 | Values: 76.0 77.0 77.0 168.0 76.0 77.0 76.0 76.0 166.0 76.0 04:41:38 INFO - PROCESS | 20951 | 04:41:38 INFO - PROCESS | 20951 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:92.00 stddev:25.69 (27.9%) stddev-sans-first:26.61 04:41:38 INFO - PROCESS | 20951 | Values: 92.0 92.0 145.0 91.0 91.0 92.0 147.0 93.0 92.0 143.0 04:41:38 INFO - PROCESS | 20951 | 04:41:38 INFO - PROCESS | 20951 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:41:38 INFO - PROCESS | 20951 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 116.0 04:41:38 INFO - PROCESS | 20951 | 04:41:38 INFO - PROCESS | 20951 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:41:38 INFO - PROCESS | 20951 | Values: 145.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 04:41:38 INFO - PROCESS | 20951 | 04:41:38 INFO - PROCESS | 20951 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 04:41:38 INFO - PROCESS | 20951 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 04:41:38 INFO - PROCESS | 20951 | 04:41:38 INFO - PROCESS | 20951 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:55.00 stddev:9.21 (16.8%) stddev-sans-first:9.74 04:41:38 INFO - PROCESS | 20951 | Values: 55.0 59.0 53.0 53.0 54.0 55.0 55.0 83.0 53.0 53.0 04:41:38 INFO - PROCESS | 20951 | 04:41:38 INFO - PROCESS | 20951 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:2.16 (3.7%) stddev-sans-first:2.24 04:41:38 INFO - PROCESS | 20951 | Values: 57.0 59.0 58.0 57.0 57.0 58.0 57.0 59.0 64.0 57.0 04:41:38 INFO - PROCESS | 20951 | 04:41:38 INFO - PROCESS | 20951 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:73.00 stddev:2.72 (3.7%) stddev-sans-first:2.87 04:41:38 INFO - PROCESS | 20951 | Values: 73.0 71.0 73.0 72.0 73.0 73.0 81.0 73.0 73.0 74.0 04:41:38 INFO - PROCESS | 20951 | 04:41:38 INFO - PROCESS | 20951 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:113.50 stddev:21.33 (18.8%) stddev-sans-first:22.44 04:41:38 INFO - PROCESS | 20951 | Values: 114.0 125.0 111.0 113.0 112.0 108.0 112.0 110.0 178.0 134.0 04:41:38 INFO - PROCESS | 20951 | 04:41:38 INFO - PROCESS | 20951 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:162.50 stddev:5.62 (3.5%) stddev-sans-first:5.83 04:41:38 INFO - PROCESS | 20951 | Values: 158.0 165.0 164.0 162.0 163.0 174.0 157.0 160.0 155.0 156.0 04:41:38 INFO - PROCESS | 20951 | 04:41:38 INFO - PROCESS | 20951 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.66 (2.5%) stddev-sans-first:0.88 04:41:38 INFO - PROCESS | 20951 | Values: 71.0 67.0 67.0 67.0 65.0 66.0 66.0 66.0 68.0 66.0 04:41:38 INFO - PROCESS | 20951 | -------- Summary: end -------- 04:41:38 INFO - PROCESS | 20951 | 04:41:38 INFO - TEST-INFO | 20951: exit 0 04:41:39 INFO - TEST-OK | kraken | took 59855ms 04:41:39 INFO - SUITE-END | took 1170s 04:41:39 INFO - Completed test suite (00:19:31) 04:41:39 INFO - javascript benchmark 04:41:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3286.9999999999995, 3311.437055700531, 3332.1836150143213, 3333.333333333334, 3345.180430794456, 5429.429909859462, 5456.8090116845915, 5462.453754624546, 5467.0705979983395, 5483.7806487740445, 5474.151506516487, 5478.123500239963, 5486.231927530139, 5488.890222195554, 5515.7242137893045, 4948.7773050212645, 4966.850994470163, 5011.14810482217, 5028.572571331423, 5092.9236061459105, 4988.950110498885, 5022.59819214462, 5031.723255220962, 5035.471275516073, 5037.420696619881, 5029.9748501257445, 5100.566451851597, 5103.055934652083, 5124.4875512448825, 5133.948660513403, 5133.84598462043, 5136.845894623168, 5152.124138896396, 5154.536091751723, 5162.199859021839, 4974.900501989976, 5021.698698078127, 5067.898642027176, 5103.693778373309, 5112.897742045176, 5469.316335458067, 5504.146857237135, 5505.559555235572, 5510.779568817243, 5516.420775818561, 5931.317898441691, 5938.0, 5938.049912014057, 5943.524518038546, 5946.0, 5967.850803729898, 5986.700664966777, 6037.879242415171, 6040.275166979946, 6073.967425537669, 5573.386927437979, 5622.97188514063, 5625.718714064321, 5630.71846407678, 5632.633878797865, 5874.853128671732, 6085.8478538036015, 6089.086637004396, 6089.665068421191, 6141.969290153521, 5823.505002074787, 5921.467067963904, 5933.228680271537, 5936.7328470218945, 5941.435563621449, 5936.881262374728, 5937.851553711105, 5939.584229104008, 5943.910841337383, 5944.821655350346, 5811.854703632443, 5859.794907178229, 5907.084401917709, 5908.645481271137, 5912.704364781744, 5994.310654274727, 6002.819915402545, 6007.128966299862, 6007.849803754941, 6045.3652366501765, 4534.070515544371, 4551.38556294896, 4557.225271703818, 4557.863264102082, 4575.313702944585, 3989.880303590897, 4009.498812648419, 4046.473958385391, 4060.3300455425115, 4096.631303182728, 5674.744636491368, 5696.458836410535, 5698.487136157766, 5702.0591602385975, 5719.828405147852, 6010.729517171738, 6033.215681961317, 6034.0, 6040.214772079602, 6045.093236014633, 5579.888402231933, 5618.690971996498, 5646.71766411686, 5706.229658995982, 5706.971465142731, 5081.212412076134, 5117.8464646060675, 5118.8976220476125, 5124.948750512447, 5149.0474262261605, 6186.412290832363, 6204.937950620436, 6216.378362163748, 6227.190465239581, 6227.346128656516, 5794.942050579441, 5992.790252341147, 6037.577369584087, 6067.180930574493, 6074.119252708421, 6185.072239164161, 6203.627782333075, 6222.377762223741, 6229.657368844576, 6236.126942228001, 5685.175649530877, 5889.204957330877, 5893.233879595625, 5899.321578018583, 5919.31927828288, 5915.911261330997, 5924.111383292368, 5970.552208584287, 5981.222441082631, 6018.187544681412, 5751.4536119068625, 5779.219805326227, 5779.971100144472, 5784.305883293863, 5789.2763404574425, 5654.0, 5680.971595141998, 5740.3685594585395, 5741.224934633938, 5757.568182386254, 5549.750261238173, 5554.527865131509, 5565.916511252415, 5573.359063707726, 5581.7209139543675, 5670.121131224667, 5674.971625142013, 5683.77264909399, 5686.175504551734, 5707.571932105192, 5590.636608620427, 5592.161175823659, 5646.407127251579, 5649.20911072442, 5708.571857110816], "value": 5480.53212867355, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.8077167235665, 667.7762949411947, 679.7043286170515, 712.3909057755619, 716.4877112864301, 33992.4901126483, 35003.82498087509, 35010.64989350106, 35088.298234035334, 40484.0, 44097.55902440983, 44285.557144428545, 44486.0, 44523.0, 44594.0, 8787.64849406023, 8972.057933916944, 8977.0, 8980.012198658142, 8980.506072166028, 8434.53610051447, 8649.913500864974, 8794.912050879473, 10775.245732798707, 11060.336379817196, 10673.306235094733, 10745.194110441747, 10745.301555398913, 10765.461726913662, 10767.515461804198, 8380.120087390796, 10601.575936962512, 10672.30630009047, 10672.573097076107, 10680.305780124267, 10301.845472317922, 10426.0, 10454.059134677915, 10464.215183861164, 10493.108085812715, 41458.0, 41688.79155604233, 41756.37365439521, 41790.58209417928, 41852.162956741, 3618.3848745713294, 3653.9086522836874, 3703.518542589473, 3772.6981841452616, 3833.9041523961846, 31610.841945790125, 31949.680503194904, 33109.0, 34609.82695086534, 34888.12779680503, 4574.542545745432, 4583.427071616048, 4588.311753237042, 4597.770111494412, 4684.688287279567, 311245.0, 316022.0, 316621.9999999977, 317015.0, 317336.0, 41104.1779164421, 66686.66656666686, 67733.32266677369, 67737.5970561912, 67786.0, 40518.79740601278, 40612.0, 40824.59175408267, 40872.59127408747, 40953.79523102365, 17229.0, 17542.91228543849, 17549.0348030857, 17598.12009399525, 17606.82393176052, 13060.738785224243, 13596.524121655695, 13597.660058498617, 13609.795853062213, 14919.328630211667, 9399.389039712534, 9466.29002824791, 9487.620495180254, 9517.333786635008, 9531.761705957406, 3177.189816596753, 3184.50640150777, 3236.9838150809096, 3258.6741325867224, 3316.5522654441825, 1049.1030169205371, 1204.7951848185653, 1270.7522033203622, 1277.6997405609675, 1281.4810001949224, 34033.48949765755, 34124.08941472739, 34330.82834585811, 34585.48121778175, 34608.82695586506, 1239.2378687107544, 1245.5017992802952, 1261.2684642907093, 1332.9666758331118, 1342.1209108034254, 18052.368167114088, 18215.72676409855, 18267.451976440727, 18297.90851045763, 18341.90829045873, 472669.0, 477707.0, 479061.0, 480960.0, 482478.0, 64066.67966660137, 64812.67593662001, 64880.0, 64949.67525162439, 65010.34989650043, 1338.9933050334687, 1486.613480495079, 1545.822230443491, 1547.0562956596468, 1626.8129165145922, 30659.693403065685, 31548.684513154574, 31569.68430315759, 31930.20174495656, 32636.0, 47770.52229477661, 48124.75937620289, 48188.5181148198, 48196.7590162047, 48244.27633585569, 297348.0, 303425.0, 304148.0, 304518.0, 304862.0, 28641.14076577706, 31271.01714251495, 31358.686413135576, 32388.0, 32414.0, 49976.0, 50737.49262507475, 50858.49141508686, 50912.23631645602, 51904.48095518997, 41793.0, 42012.789936050125, 42138.0, 42405.1518969625, 43545.0, 40635.796821015705, 40759.796201018806, 41129.38305925354, 42570.14859702727, 42627.0, 43347.34978975381, 44038.55961440344, 44489.11021779611, 44650.55349446594, 44861.77569112134, 34499.65500345065, 37570.8121459391, 37643.247135057696, 37904.0, 38155.618443815205, 29391.706082939752, 29501.704982949897, 29535.85232073826, 29891.252718682208, 30057.248568785082], "value": 19744.029643388287, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.2391630938774, 428.539320230752, 435.70589851850013, 437.22174529337775, 441.15959097918477, 17231.569210769736, 18071.63856722865, 18744.531386715324, 18752.90623546882, 19080.33218837341, 18275.36036238732, 18469.35357262496, 18545.536361590934, 19268.80731192691, 19285.0, 5638.971805140968, 5677.17680936264, 5904.409559044083, 5905.468507834294, 5932.37710040446, 5871.383504731984, 5891.234139561851, 5901.586888917777, 5904.350521442638, 5912.733926973297, 5783.5084017858535, 5896.557758168155, 5897.439743224387, 6395.072714456401, 6448.742050317982, 6279.780207692755, 6309.242890853127, 6374.17135772349, 6417.454516366114, 6418.42234198922, 5754.625949313281, 5763.884722305573, 5899.646021238696, 5959.374265702082, 5965.403459654043, 13985.650358741012, 14231.0, 14231.857681423156, 15992.92003539975, 23597.29208123759, 2423.6849209602815, 2447.351451865239, 2561.9615705764427, 2569.678790151231, 3024.123004328742, 10344.431056291902, 10345.844812327821, 10662.466876656214, 10670.73323166927, 10872.0, 1805.810389909067, 1840.7975122736489, 1946.9805301947083, 2165.372042107787, 2237.697910782056, 81028.59485702592, 82068.9999999994, 82915.0, 83313.58343208306, 87436.0, 11209.887901121048, 11301.49143288554, 11344.943275283571, 11594.71013224676, 11765.411729413496, 16173.0, 16272.18639068042, 16371.918140409221, 16411.91794041046, 16412.917935410245, 9159.542022898962, 9185.402948808307, 9186.448813071238, 9208.171264586219, 9250.259979201783, 9136.908630913606, 9155.313351498664, 9172.220361269367, 9198.49408282551, 9231.399959002643, 5010.949890501121, 5027.2207807789855, 5047.167217409086, 5050.116229659869, 5085.1355269604255, 1999.5201151723481, 2023.7267968824315, 2053.035073515445, 2074.647309957311, 2077.1483691686335, 1029.9975571209839, 1124.859392575928, 1127.5546159267044, 1128.4132251229314, 1153.988460115388, 18499.260029598936, 19406.2237510498, 19613.80386196148, 20243.493912652302, 20996.47508812292, 1040.5837664933936, 1059.0468578279456, 1059.8251288537306, 1154.8325492803665, 1171.9296842189497, 10757.0, 11139.554417823196, 11170.776584468265, 11175.273607215506, 11230.55077796879, 537175.0, 539827.0, 554363.0, 556357.0, 556466.0, 90452.0, 93072.53463732637, 94691.52654236685, 94973.05026949642, 95339.52330238304, 1122.3434290939892, 1141.9771604567861, 1173.5531416995489, 1194.5580135349976, 1214.7388311513066, 17155.70243996842, 17556.912215438842, 17671.0, 17672.38146664912, 17781.19984600722, 41825.163496729285, 41991.7900410496, 42460.363094554225, 42721.0, 42889.57110428856, 58931.410685894305, 60076.69961650164, 60122.39877601168, 60465.69767151136, 60470.09294860493, 9148.130927561871, 9233.769155771159, 9249.352545322032, 9425.57584908667, 9507.096825801538, 13331.466741330238, 13780.65548361299, 13865.376058077612, 14202.28988550589, 14242.928785356007, 12292.754144917231, 12341.457317835271, 12372.505099796268, 12649.557265495663, 12720.618381448572, 12006.279623222634, 12222.633321000385, 12274.38628068575, 12308.507659693512, 12422.06834487399, 12086.576969806014, 12526.874731252936, 12653.87346126527, 12759.553415630407, 12791.232526048467, 8949.642014319354, 9068.274538036809, 9110.225630821455, 9284.628614855601, 9372.81254374895, 12142.635720928387, 12442.253464792142, 12442.75114497723, 12521.248725076524, 12570.43433045497], "value": 9663.35547510973, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.4957240179729, 1558.2754019380989, 1570.1050401271277, 1725.318499192818, 1834.6972749496333, 7617.162112167664, 8211.425200235986, 8273.586320683964, 8276.875846862287, 8293.626786794593, 8172.264496195341, 8325.209105135018, 8346.248837604615, 8370.288525475342, 8375.246227839492, 2117.0473287020827, 2365.60967440373, 2411.5297516984238, 2417.2144053182697, 2431.6474111253856, 2421.0315873650507, 2430.1980346485707, 2432.391902024494, 2433.9269821905373, 2434.3548959525738, 2317.6639387288833, 2393.5811233034237, 2398.7361390247147, 2401.399650087478, 2405.3625789165885, 2135.348718640814, 2281.954360912781, 2303.7120359955006, 2318.258157389636, 2322.512272422793, 2193.670949357593, 2216.556688662274, 2229.885057471264, 2232.877191754469, 2256.187772401934, 8192.18078192182, 8252.092269850311, 8254.05078415978, 8259.752207433727, 8262.132476089984, 5197.974010129963, 5279.868003299948, 5353.357597088374, 5361.919571206435, 5398.6220964532495, 3453.637368076341, 3504.7721898076798, 3521.6126226115107, 3533.152043509565, 3582.946255806165, 1110.6057349640923, 1136.79537683217, 1160.3154139057913, 1176.6587689570015, 1203.7652657731746, 12203.816942745865, 12214.145009849313, 12241.20432171915, 12256.0, 12294.938525307316, 4851.58761505276, 4858.73276969763, 4878.56092951636, 4906.779194936236, 4937.5556199942175, 10359.430231337197, 10365.9481702591, 10374.118199952938, 10377.792444151226, 10382.792344153075, 4932.654714170046, 5589.496945274945, 5593.3847276799515, 5594.776208951596, 5603.943960560424, 4852.223644216909, 4861.052094841542, 4877.878053048631, 4880.097182021337, 4909.754512274443, 4051.554329023805, 4084.6119618636776, 4123.2165888481095, 4161.771102589326, 4163.666906647461, 1297.0920355751011, 1305.549585393038, 1307.4443361571293, 1311.672081979505, 1325.204877073748, 850.4472093139385, 925.6898938855425, 966.8984756600596, 975.2198241406846, 1014.1379827146866, 5723.084306511021, 5745.195672605839, 5746.42535746422, 5871.853203669943, 5992.40075992406, 444.07410549005687, 445.3920398655811, 449.69870186974805, 451.4289423878796, 467.89940162865145, 3779.508663873734, 3812.599677033927, 3814.3706288462095, 3833.4441505981476, 3859.073822282632, 10221.591136354611, 10624.043836054792, 10647.094996925349, 10703.571857125784, 10731.0, 10275.74310642225, 10496.212784041227, 10516.26386152962, 10629.149668026539, 10657.680269591925, 8106.351491880518, 8154.14381489935, 8160.0, 8192.426530142951, 8279.8344033119, 5475.425080366664, 5488.286522752017, 5547.750351234285, 5602.411746766694, 5692.743826527733, 9045.321600879828, 9503.144716975505, 9675.564599592895, 9681.419114853132, 9721.756956076155, 9421.340506164503, 9633.181179599533, 9676.85484717744, 9851.852222216528, 9856.063673950963, 6845.760398386033, 7037.592481503617, 7151.570905745672, 7627.809304767426, 7713.730019449293, 7950.840983180188, 7967.721129760431, 7996.84006319882, 8018.3585313173635, 8047.155048720034, 7012.7545535906, 7148.0, 7222.277772222736, 7275.090613673291, 7376.151742549676, 7279.308465695751, 7329.450291228072, 7335.926640733524, 7459.813504662427, 7477.588732619758, 7073.6463176839925, 7081.858362832818, 7121.537100088478, 7123.501354905314, 7152.570845749272, 4790.688605240648, 4795.976020120017, 4836.854894353175, 4873.171560834738, 4888.462269150319, 4995.25071239317, 4995.825146119869, 5005.724685142352, 5008.57427118699, 5072.391313042459], "value": 4482.753677368634, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.525820658524, 359.62598897146967, 363.2897685025775, 363.71811845819497, 366.5107082045469, 6288.528360372973, 6345.175127233459, 6353.174087368647, 6373.776917807866, 6407.231132264129, 6297.433231009209, 6372.426481616653, 6373.521985851056, 6377.968110159442, 6387.137736405584, 4625.098105869349, 4667.13657973276, 4817.253325734499, 4845.248986407112, 4847.757612119398, 4812.663113582051, 4815.879603009936, 4844.346013288214, 4862.659613827033, 4867.634927380443, 4594.104149690795, 4814.253790662453, 4818.831340903069, 4819.493953134923, 4826.782794774226, 4644.094401591691, 4677.134730074947, 4712.246040633499, 4750.596199323062, 4764.475907650156, 4211.494620645542, 4218.683598730107, 4220.198162349144, 4239.342901850187, 4244.681648876347, 6029.638221706711, 6042.486388656969, 6047.183630209909, 6049.909251361233, 6056.636601803862, 5581.469760372758, 5584.5253153482, 5592.5246354059955, 5595.692236926968, 5602.943970560283, 6460.96624540076, 6590.044443555657, 6593.703283352213, 6601.867962640768, 6604.405603495708, 4694.671373003891, 4699.060187962421, 4699.201135806921, 4703.17694403478, 4714.1985862403135, 6839.829004274883, 6864.897026544606, 6886.827829304258, 6899.482538809559, 6918.481113916426, 4775.116603428377, 4812.1578723723205, 4812.951870481321, 4815.181419158752, 4818.951810481921, 4865.854024379274, 4873.805047798049, 4875.609951203895, 4877.829275975324, 4883.975580122076, 5572.247746554163, 5572.582056345709, 5574.637648552913, 5583.497485226268, 5594.356648985418, 6431.517636177306, 6638.269790323061, 6651.767188148391, 6655.767048153291, 6672.532922695462, 1675.6397374564283, 1724.5860993361503, 1724.7067998440295, 1727.5422013166522, 1727.576743697777, 1082.5128692088592, 1143.0741099709262, 1150.9482073306554, 1157.2073129906041, 1167.53882216524, 6320.747170113144, 6476.740930362827, 6500.739970401131, 6530.314316996742, 6537.0, 6883.621400822903, 6901.309869013159, 6903.6203008835, 6906.033155358254, 6926.341997510229, 6489.0266460030425, 6493.610383377012, 6504.121943537656, 6504.902426463606, 6512.088307636935, 3694.2057457646733, 3737.121776382548, 3737.177820879402, 3746.306933217309, 3751.306008388457, 7075.4903903309305, 7128.893066604005, 7181.964090179516, 7216.422686185093, 7223.349898509159, 6946.305369463114, 6968.407685346701, 7006.299370063055, 7030.332118448841, 7036.437085033185, 7086.0, 7117.786466406016, 7151.463640227003, 7158.427325813923, 7175.605341706152, 6868.450523957971, 6872.037914692047, 6875.759348422981, 6891.0, 6906.896396554156, 6626.469882409492, 6820.590764554143, 6838.0084887692, 6878.931210688029, 6884.8967265490055, 7176.928230717626, 7224.277572242734, 7241.927580724126, 7251.782446526613, 7257.891131632924, 4700.083483720641, 4736.313234581035, 4751.073540659539, 4751.168545504592, 4758.619310455086, 6938.271481494572, 6940.861182776417, 6946.235914049552, 6948.826279343057, 6954.860902782018, 6543.985682219263, 6763.2222294434805, 6766.458683305422, 6788.626625535446, 6791.422729068085, 6684.7326106957125, 6715.93284067153, 6729.5625784323865, 6734.8653026940165, 6737.797866064026, 6601.735930562723, 6616.801495955129, 6618.801435956929, 6618.867622647616, 6621.33786621334, 6768.96615516939, 6771.762988295583, 6797.966010170116, 6802.081718967876, 6851.760188393581, 6468.062130991074, 6599.472042236705, 6608.7026083825385, 6618.2719900811835, 6629.7348106075215], "value": 5061.860488450345, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.073324842037, 904.4528060523385, 916.408916249019, 923.4551614547415, 931.329442801183, 14476.63808404789, 14771.926140369284, 14785.926070369633, 14819.925900370497, 14823.555293341204, 13232.13991090581, 14690.779638305434, 14716.85283147171, 14734.115953042798, 14749.188794616291, 882.567541904467, 893.678275820704, 895.1093661806511, 899.9865002024975, 902.467544148952, 835.7325655790149, 883.2889523933231, 889.8353804546148, 889.8531742262519, 893.8391089603869, 902.62992173209, 933.3186773655236, 935.7473482159813, 936.1761649748246, 941.6845356805478, 898.6091050393068, 927.3832901120746, 930.5812384427035, 930.8929473110611, 934.1032608695592, 656.4780999105723, 669.0299066353806, 678.0879716780922, 681.3901558105517, 682.0349205873683, 13726.313684315744, 13907.165570065828, 13913.095648782797, 13925.721485570333, 13953.302334883216, 13274.269915154662, 13285.0, 13291.800622990662, 13320.666983325398, 13325.800112998313, 10816.134709223243, 11094.44527773608, 11110.833337499864, 11132.220744547885, 11165.72085697856, 3899.492103801279, 3927.175293188434, 3948.506436695413, 3965.6232657897453, 3981.064449854282, 50705.23942140871, 50973.745131274474, 53206.73396632992, 58311.416885831444, 58622.70688646572, 11965.46155423008, 11970.940145299217, 12092.0, 12122.27266364021, 12408.379581020912, 20600.072996715186, 20676.276330328365, 20715.4821129473, 20724.792752072586, 20813.479663008548, 8880.955595221982, 8946.194842464209, 9112.544372781467, 9177.862332065024, 9318.813623727487, 4734.342979956988, 4845.152098382769, 4908.2637604358915, 4936.506349365035, 5024.221245706921, 3665.7617254878883, 3691.557013158438, 3697.6302369762807, 3701.722370822199, 3734.3091528067393, 655.4788942790493, 672.6098862659645, 676.7496026470237, 680.9489288303298, 690.526989012528, 672.6233309346782, 682.8770821252123, 686.7287421468492, 692.7609974558769, 726.8001299642535, 9243.39917905334, 9637.903620963842, 9693.369930954465, 9784.119429251401, 9791.510424478747, 710.6801939127309, 713.8500914807948, 714.2322003845886, 721.9099160268033, 731.4806487393904, 4264.7654379009455, 4299.484061912591, 4411.316245981878, 4435.866923992286, 4567.862964111082, 62469.68765156145, 62584.0, 63418.0, 65220.0, 65311.34688653148, 51745.48254517482, 52102.0, 52265.47734522682, 52513.2123018155, 55309.0, 46966.0, 50671.746641267295, 51023.0, 51418.228726569134, 51815.96368072618, 9207.447553146565, 9352.205062569758, 9519.714408567754, 9589.568469419033, 9593.616255349707, 37949.241015180094, 38213.0, 38609.613903860605, 38830.223395531364, 39443.80278098706, 48106.27840582324, 49127.75436122796, 50245.49754502408, 50570.0, 51071.0, 12236.26582405023, 12759.0, 13009.739805204032, 13082.607521774362, 13388.19670819754, 14099.929500352433, 14225.644358890697, 14298.0, 14518.20149891766, 14900.0314979526, 13506.0, 13522.459101635824, 13603.659908501972, 13701.246431446367, 13732.45070197181, 13053.608391747883, 13471.057026008086, 13490.258035808125, 13568.118072325267, 13712.588622341345, 13256.53602123921, 13652.453901844212, 13698.246596437291, 13729.107608005448, 13749.725005499635, 11086.944565277123, 11173.441327933408, 11272.830907536558, 11384.48769805344, 11540.24988375753, 10991.61529346469, 11311.208215424842, 11367.147463940402, 11433.142514311294, 11568.24806387582], "value": 7089.917647995855, "unit": "score"}], "name": "dromaeo_css", "value": 7429.969285913684, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 111.0, 110.0, 111.0, 111.0, 105.0, 109.0, 110.0, 107.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 150.0, 187.0, 140.0, 156.0, 152.0, 133.0, 182.0, 135.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 162.0, 162.0, 160.0, 161.0, 161.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 168.0, 76.0, 77.0, 76.0, 76.0, 166.0, 76.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 145.0, 91.0, 91.0, 92.0, 147.0, 93.0, 92.0, 143.0], "value": 107.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 53.0, 53.0, 54.0, 55.0, 55.0, 83.0, 53.0, 53.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 58.0, 57.0, 57.0, 58.0, 57.0, 59.0, 64.0, 57.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 73.0, 72.0, 73.0, 73.0, 81.0, 73.0, 73.0, 74.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 125.0, 111.0, 113.0, 112.0, 108.0, 112.0, 110.0, 178.0, 134.0], "value": 121.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 165.0, 164.0, 162.0, 163.0, 174.0, 157.0, 160.0, 155.0, 156.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 67.0, 67.0, 65.0, 66.0, 66.0, 66.0, 68.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1520.9, "alertThreshold": 2.0}]} 04:41:39 INFO - Return code: 0 04:41:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:41:39 ERROR - # TBPL SUCCESS # 04:41:39 INFO - Running post-action listener: _resource_record_post_action 04:41:39 INFO - Running post-run listener: _resource_record_post_run 04:41:40 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 503205888; Read time: 12; Write time: 490588 04:41:40 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248573952; Read time: 0; Write time: 301212 04:41:40 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250580992; Read time: 12; Write time: 188540 04:41:40 INFO - Running post-run listener: _upload_blobber_files 04:41:40 INFO - Blob upload gear active. 04:41:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:41:40 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 04:41:40 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'] 04:41:40 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 04:41:40 INFO - (blobuploader) - INFO - Open directory for files ... 04:41:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:41:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:41:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:41 INFO - (blobuploader) - INFO - Done attempting. 04:41:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:41:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:41:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:42 INFO - (blobuploader) - INFO - Done attempting. 04:41:42 INFO - (blobuploader) - INFO - Iteration through files over. 04:41:42 INFO - Return code: 0 04:41:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:41:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:41:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/167a88cd7483070ad23c573083e907be230d1131684e1c49a45f6512463ca8425ce185c3d78b7638e9ccb65151a18583bf2b821e784d38a6076501d46f053d2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c4e3a7c8800c921bdb44db2f1c5201c83e834f188c36f27c9b6bbada31e545ee007b2bf26794f505f7a237492c0993d71bb18643203d5384f33faf016f333f0"} 04:41:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:41:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:41:42 INFO - Contents: 04:41:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/167a88cd7483070ad23c573083e907be230d1131684e1c49a45f6512463ca8425ce185c3d78b7638e9ccb65151a18583bf2b821e784d38a6076501d46f053d2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c4e3a7c8800c921bdb44db2f1c5201c83e834f188c36f27c9b6bbada31e545ee007b2bf26794f505f7a237492c0993d71bb18643203d5384f33faf016f333f0"} 04:41:42 INFO - Running post-run listener: copy_logs_to_upload_dir 04:41:42 INFO - Copying logs to upload dir... 04:41:42 INFO - mkdir: /builds/slave/test/build/upload/logs 04:41:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.861968 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-06 04:41:41.357228) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 04:41:41.361148) ========= 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=523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060 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/167a88cd7483070ad23c573083e907be230d1131684e1c49a45f6512463ca8425ce185c3d78b7638e9ccb65151a18583bf2b821e784d38a6076501d46f053d2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c4e3a7c8800c921bdb44db2f1c5201c83e834f188c36f27c9b6bbada31e545ee007b2bf26794f505f7a237492c0993d71bb18643203d5384f33faf016f333f0"} build_url:https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/CZULdrJzSvuOvylse2l50g/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/167a88cd7483070ad23c573083e907be230d1131684e1c49a45f6512463ca8425ce185c3d78b7638e9ccb65151a18583bf2b821e784d38a6076501d46f053d2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c4e3a7c8800c921bdb44db2f1c5201c83e834f188c36f27c9b6bbada31e545ee007b2bf26794f505f7a237492c0993d71bb18643203d5384f33faf016f333f0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 04:41:41.387004) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:41:41.387368) ========= 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=523ca41ca1e0623de333ad52000001bf-1462533674.437702-570665060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 04:41:41.472025) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 04:41:41.472672) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 04:41:41.473125) ========= ========= Total master_lag: 0.16 =========