builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1461151860.49 results: success (0) buildid: 20160420025335 builduid: e2070c3864bc4993b0fae819a230d9d2 revision: e9088179190a3129cc705ea795e40669c97327d0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 04:31:00.494712) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 04:31:00.495207) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 04:31:00.495515) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 04:31:00.515202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:31:00.515563) ========= 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=eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 04:31:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.7M=0s 2016-04-20 04:31:00 (69.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074756 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:31:00.603496) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:31:00.603835) ========= 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=eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013615 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:31:00.661437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:31:00.661889) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e9088179190a3129cc705ea795e40669c97327d0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e9088179190a3129cc705ea795e40669c97327d0 --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=eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 04:31:00,742 truncating revision to first 12 chars 2016-04-20 04:31:00,742 Setting DEBUG logging. 2016-04-20 04:31:00,742 attempt 1/10 2016-04-20 04:31:00,742 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e9088179190a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 04:31:01,034 unpacking tar archive at: fx-team-e9088179190a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.561619 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:31:01.236877) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 04:31:01.240262) ========= script_repo_revision: e9088179190a3129cc705ea795e40669c97327d0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 04:31:01.240721) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 04:31:01.240994) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 04:31:01.251111) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-20 04:31:01.251509) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:31:01 INFO - MultiFileLogger online at 20160420 04:31:01 in /builds/slave/test 04:31:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:31:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:31:01 INFO - {'append_to_log': False, 04:31:01 INFO - 'base_work_dir': '/builds/slave/test', 04:31:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:31:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:31:01 INFO - 'branch': 'Fx-Team-Non-PGO', 04:31:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:31:01 INFO - 'config_files': ('talos/linux_config.py',), 04:31:01 INFO - 'default_actions': ('clobber', 04:31:01 INFO - 'read-buildbot-config', 04:31:01 INFO - 'download-and-extract', 04:31:01 INFO - 'populate-webroot', 04:31:01 INFO - 'create-virtualenv', 04:31:01 INFO - 'install', 04:31:01 INFO - 'run-tests'), 04:31:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:31:01 INFO - 'download_minidump_stackwalk': True, 04:31:01 INFO - 'download_symbols': 'ondemand', 04:31:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:31:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:31:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:31:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:31:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:31:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:31:01 INFO - 'installer_path': 'installer.exe', 04:31:01 INFO - 'log_level': 'info', 04:31:01 INFO - 'log_name': 'talos', 04:31:01 INFO - 'log_to_console': True, 04:31:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:31:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:31:01 INFO - 'opt_config_files': (), 04:31:01 INFO - 'pip_index': False, 04:31:01 INFO - 'sps_profile': False, 04:31:01 INFO - 'sps_profile_interval': 0, 04:31:01 INFO - 'suite': 'dromaeojs', 04:31:01 INFO - 'system_bits': '32', 04:31:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:31:01 INFO - 'title': 'talos-linux64-ix-010', 04:31:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:31:01 INFO - 'use_talos_json': True, 04:31:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:31:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:31:01 INFO - 'work_dir': 'build'} 04:31:01 INFO - ##### 04:31:01 INFO - ##### Running clobber step. 04:31:01 INFO - ##### 04:31:01 INFO - Running pre-action listener: _resource_record_pre_action 04:31:01 INFO - Running main action method: clobber 04:31:01 INFO - rmtree: /builds/slave/test/build 04:31:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:31:02 INFO - Running post-action listener: _resource_record_post_action 04:31:02 INFO - ##### 04:31:02 INFO - ##### Running read-buildbot-config step. 04:31:02 INFO - ##### 04:31:02 INFO - Running pre-action listener: _resource_record_pre_action 04:31:02 INFO - Running main action method: read_buildbot_config 04:31:02 INFO - Using buildbot properties: 04:31:02 INFO - { 04:31:02 INFO - "project": "", 04:31:02 INFO - "product": "firefox", 04:31:02 INFO - "script_repo_revision": "production", 04:31:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:31:02 INFO - "repository": "", 04:31:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:31:02 INFO - "buildid": "20160420025335", 04:31:02 INFO - "pgo_build": "False", 04:31:02 INFO - "basedir": "/builds/slave/test", 04:31:02 INFO - "buildnumber": 1683, 04:31:02 INFO - "slavename": "talos-linux64-ix-010", 04:31:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:31:02 INFO - "platform": "ubuntu64_hw", 04:31:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:31:02 INFO - "branch": "fx-team", 04:31:02 INFO - "repo_path": "integration/fx-team", 04:31:02 INFO - "revision": "e9088179190a3129cc705ea795e40669c97327d0", 04:31:02 INFO - "stage_platform": "linux64", 04:31:02 INFO - "builduid": "e2070c3864bc4993b0fae819a230d9d2", 04:31:02 INFO - "slavebuilddir": "test" 04:31:02 INFO - } 04:31:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:31:02 INFO - Running post-action listener: _resource_record_post_action 04:31:02 INFO - ##### 04:31:02 INFO - ##### Running download-and-extract step. 04:31:02 INFO - ##### 04:31:02 INFO - Running pre-action listener: _resource_record_pre_action 04:31:02 INFO - Running main action method: download_and_extract 04:31:02 INFO - mkdir: /builds/slave/test/build/tests 04:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:02 INFO - https://queue.taskcluster.net/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:31:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:31:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:31:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:31:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:31:03 INFO - Downloaded 1361 bytes. 04:31:03 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:31:03 INFO - Using the following test package requirements: 04:31:03 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:31:03 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:31:03 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:31:03 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:03 INFO - u'jsshell-linux-x86_64.zip'], 04:31:03 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:31:03 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:31:03 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:31:03 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:31:03 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:31:03 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:31:03 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:03 INFO - https://queue.taskcluster.net/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:31:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:31:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:31:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:31:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:31:04 INFO - Downloaded 22267803 bytes. 04:31:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:31:05 INFO - Return code: 0 04:31:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:31:05 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:31:05 INFO - https://queue.taskcluster.net/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:31:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:31:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:31:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:31:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:31:07 INFO - Downloaded 22267803 bytes. 04:31:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:31:08 INFO - Return code: 0 04:31:08 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:31:08 INFO - https://queue.taskcluster.net/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:31:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:31:09 INFO - Downloaded 10845952 bytes. 04:31:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:31:09 INFO - Return code: 0 04:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:09 INFO - https://queue.taskcluster.net/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:31:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:31:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:31:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:31:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:31:11 INFO - Downloaded 54599921 bytes. 04:31:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:31:11 INFO - mkdir: /builds/slave/test/properties 04:31:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:11 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:11 INFO - Contents: 04:31:11 INFO - build_url:https://queue.taskcluster.net/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:31:12 INFO - Running post-action listener: _resource_record_post_action 04:31:12 INFO - Running post-action listener: set_extra_try_arguments 04:31:12 INFO - ##### 04:31:12 INFO - ##### Running populate-webroot step. 04:31:12 INFO - ##### 04:31:12 INFO - Running pre-action listener: _resource_record_pre_action 04:31:12 INFO - Running main action method: populate_webroot 04:31:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:12 INFO - '--tppagecycles', 04:31:12 INFO - '7'], 04:31:12 INFO - 'tests': ['tsvgm']}}, 04:31:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:31:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:31:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:31:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:31:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:31:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:12 INFO - 'talos_options': ['--disable-e10s'], 04:31:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:12 INFO - 'talos_options': ['--disable-e10s'], 04:31:12 INFO - 'tests': ['damp', 'tps']}, 04:31:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:12 INFO - 'tests': ['damp', 'tps']}, 04:31:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:31:12 INFO - 'tests': ['dromaeo_dom']}, 04:31:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:31:12 INFO - 'tests': ['a11yr', 04:31:12 INFO - 'ts_paint', 04:31:12 INFO - 'tpaint', 04:31:12 INFO - 'sessionrestore', 04:31:12 INFO - 'sessionrestore_no_auto_restore', 04:31:12 INFO - 'tabpaint']}, 04:31:12 INFO - 'other-e10s': {'tests': ['a11yr', 04:31:12 INFO - 'ts_paint', 04:31:12 INFO - 'tpaint', 04:31:12 INFO - 'sessionrestore', 04:31:12 INFO - 'sessionrestore_no_auto_restore', 04:31:12 INFO - 'tabpaint']}, 04:31:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:31:12 INFO - 'ts_paint', 04:31:12 INFO - 'tpaint', 04:31:12 INFO - 'sessionrestore', 04:31:12 INFO - 'sessionrestore_no_auto_restore', 04:31:12 INFO - 'tabpaint']}, 04:31:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:31:12 INFO - 'ts_paint', 04:31:12 INFO - 'tpaint', 04:31:12 INFO - 'sessionrestore', 04:31:12 INFO - 'sessionrestore_no_auto_restore', 04:31:12 INFO - 'tabpaint']}, 04:31:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:31:12 INFO - 'tests': ['a11yr', 04:31:12 INFO - 'ts_paint', 04:31:12 INFO - 'tpaint', 04:31:12 INFO - 'sessionrestore', 04:31:12 INFO - 'sessionrestore_no_auto_restore', 04:31:12 INFO - 'tabpaint']}, 04:31:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:31:12 INFO - 'tests': ['a11yr', 04:31:12 INFO - 'ts_paint', 04:31:12 INFO - 'tpaint', 04:31:12 INFO - 'sessionrestore', 04:31:12 INFO - 'sessionrestore_no_auto_restore', 04:31:12 INFO - 'tabpaint']}, 04:31:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:31:12 INFO - 'tests': ['tsvgx', 04:31:12 INFO - 'tsvgr_opacity', 04:31:12 INFO - 'tart', 04:31:12 INFO - 'tscrollx', 04:31:12 INFO - 'cart']}, 04:31:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:31:12 INFO - 'tsvgr_opacity', 04:31:12 INFO - 'tart', 04:31:12 INFO - 'tscrollx', 04:31:12 INFO - 'cart']}, 04:31:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:12 INFO - 'talos_options': ['--disable-e10s'], 04:31:12 INFO - 'tests': ['tp5o']}, 04:31:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:12 INFO - 'tests': ['tp5o']}, 04:31:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:12 INFO - 'talos_options': ['--disable-e10s', 04:31:12 INFO - '--xperf_path', 04:31:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:12 INFO - 'tests': ['tp5n']}, 04:31:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:12 INFO - 'talos_options': ['--xperf_path', 04:31:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:12 INFO - 'tests': ['tp5n']}}, 04:31:12 INFO - 'talos.zip': {'path': '', 04:31:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:12 INFO - Running post-action listener: _resource_record_post_action 04:31:12 INFO - ##### 04:31:12 INFO - ##### Running create-virtualenv step. 04:31:12 INFO - ##### 04:31:12 INFO - Running pre-action listener: _resource_record_pre_action 04:31:12 INFO - Running main action method: create_virtualenv 04:31:12 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:12 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:31:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:12 INFO - Using real prefix '/usr' 04:31:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:13 INFO - Installing distribute.............................................................................................................................................................................................done. 04:31:14 INFO - Installing pip.................done. 04:31:14 INFO - Return code: 0 04:31:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9466846f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0d410>, '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 0x1c0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e7a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', '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:31:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:31:14 INFO - Using env: {'DISPLAY': ':0', 04:31:14 INFO - 'HOME': '/home/cltbld', 04:31:14 INFO - 'LANG': 'en_US.UTF-8', 04:31:14 INFO - 'LANGUAGE': 'en_US:en', 04:31:14 INFO - 'LOGNAME': 'cltbld', 04:31:14 INFO - 'MAIL': '/var/mail/cltbld', 04:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:14 INFO - 'MOZ_NO_REMOTE': '1', 04:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:14 INFO - 'NO_EM_RESTART': '1', 04:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:14 INFO - 'PWD': '/builds/slave/test', 04:31:14 INFO - 'SHELL': '/bin/bash', 04:31:14 INFO - 'SHLVL': '1', 04:31:14 INFO - 'TERM': 'linux', 04:31:14 INFO - 'TMOUT': '86400', 04:31:14 INFO - 'USER': 'cltbld', 04:31:14 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', 04:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:14 INFO - '_': '/tools/buildbot/bin/python'} 04:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:15 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:31:15 INFO - Cleaning up... 04:31:15 INFO - Return code: 0 04:31:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9466846f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0d410>, '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 0x1c0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e7a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', '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:31:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:31:15 INFO - Using env: {'DISPLAY': ':0', 04:31:15 INFO - 'HOME': '/home/cltbld', 04:31:15 INFO - 'LANG': 'en_US.UTF-8', 04:31:15 INFO - 'LANGUAGE': 'en_US:en', 04:31:15 INFO - 'LOGNAME': 'cltbld', 04:31:15 INFO - 'MAIL': '/var/mail/cltbld', 04:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:15 INFO - 'MOZ_NO_REMOTE': '1', 04:31:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:15 INFO - 'NO_EM_RESTART': '1', 04:31:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:15 INFO - 'PWD': '/builds/slave/test', 04:31:15 INFO - 'SHELL': '/bin/bash', 04:31:15 INFO - 'SHLVL': '1', 04:31:15 INFO - 'TERM': 'linux', 04:31:15 INFO - 'TMOUT': '86400', 04:31:15 INFO - 'USER': 'cltbld', 04:31:15 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', 04:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:15 INFO - '_': '/tools/buildbot/bin/python'} 04:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:15 INFO - Downloading/unpacking psutil>=0.7.1 04:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:31:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:17 INFO - Installing collected packages: psutil 04:31:17 INFO - Running setup.py install for psutil 04:31:17 INFO - building 'psutil._psutil_linux' extension 04:31:17 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:31:17 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:31:17 INFO - building 'psutil._psutil_posix' extension 04:31:17 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:31:17 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:31:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:17 INFO - Successfully installed psutil 04:31:17 INFO - Cleaning up... 04:31:17 INFO - Return code: 0 04:31:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:31: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:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:17 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 0x7f9466846f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0d410>, '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 0x1c0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e7a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', '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:31:17 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:31:17 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:31:17 INFO - Using env: {'DISPLAY': ':0', 04:31:17 INFO - 'HOME': '/home/cltbld', 04:31:17 INFO - 'LANG': 'en_US.UTF-8', 04:31:17 INFO - 'LANGUAGE': 'en_US:en', 04:31:17 INFO - 'LOGNAME': 'cltbld', 04:31:17 INFO - 'MAIL': '/var/mail/cltbld', 04:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:18 INFO - 'MOZ_NO_REMOTE': '1', 04:31:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:18 INFO - 'NO_EM_RESTART': '1', 04:31:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:18 INFO - 'PWD': '/builds/slave/test', 04:31:18 INFO - 'SHELL': '/bin/bash', 04:31:18 INFO - 'SHLVL': '1', 04:31:18 INFO - 'TERM': 'linux', 04:31:18 INFO - 'TMOUT': '86400', 04:31:18 INFO - 'USER': 'cltbld', 04:31:18 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', 04:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:18 INFO - '_': '/tools/buildbot/bin/python'} 04:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:31:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:31:20 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:31:20 INFO - Installing collected packages: mozsystemmonitor 04:31:20 INFO - Running setup.py install for mozsystemmonitor 04:31:20 INFO - Successfully installed mozsystemmonitor 04:31:20 INFO - Cleaning up... 04:31:20 INFO - Return code: 0 04:31:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:31: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:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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:31:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:20 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 0x7f9466846f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0d410>, '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 0x1c0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e7a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', '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:31:20 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:31:20 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:31:20 INFO - Using env: {'DISPLAY': ':0', 04:31:20 INFO - 'HOME': '/home/cltbld', 04:31:20 INFO - 'LANG': 'en_US.UTF-8', 04:31:20 INFO - 'LANGUAGE': 'en_US:en', 04:31:20 INFO - 'LOGNAME': 'cltbld', 04:31:20 INFO - 'MAIL': '/var/mail/cltbld', 04:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:20 INFO - 'MOZ_NO_REMOTE': '1', 04:31:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:20 INFO - 'NO_EM_RESTART': '1', 04:31:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:20 INFO - 'PWD': '/builds/slave/test', 04:31:20 INFO - 'SHELL': '/bin/bash', 04:31:20 INFO - 'SHLVL': '1', 04:31:20 INFO - 'TERM': 'linux', 04:31:20 INFO - 'TMOUT': '86400', 04:31:20 INFO - 'USER': 'cltbld', 04:31:20 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', 04:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:20 INFO - '_': '/tools/buildbot/bin/python'} 04:31:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:20 INFO - Downloading/unpacking blobuploader==1.2.4 04:31:20 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:31:20 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:31:20 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:31:20 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:31:20 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:31:20 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:31:22 INFO - Downloading blobuploader-1.2.4.tar.gz 04:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:31:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:31:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:23 INFO - Downloading docopt-0.6.1.tar.gz 04:31:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:31:23 INFO - Installing collected packages: blobuploader, requests, docopt 04:31:23 INFO - Running setup.py install for blobuploader 04:31:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:31:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:31:23 INFO - Running setup.py install for requests 04:31:23 INFO - Running setup.py install for docopt 04:31:23 INFO - Successfully installed blobuploader requests docopt 04:31:23 INFO - Cleaning up... 04:31:23 INFO - Return code: 0 04:31:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31: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:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:23 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 0x7f9466846f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0d410>, '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 0x1c0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e7a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', '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:31:23 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:31:23 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:31:23 INFO - Using env: {'DISPLAY': ':0', 04:31:23 INFO - 'HOME': '/home/cltbld', 04:31:23 INFO - 'LANG': 'en_US.UTF-8', 04:31:23 INFO - 'LANGUAGE': 'en_US:en', 04:31:23 INFO - 'LOGNAME': 'cltbld', 04:31:23 INFO - 'MAIL': '/var/mail/cltbld', 04:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:23 INFO - 'MOZ_NO_REMOTE': '1', 04:31:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:23 INFO - 'NO_EM_RESTART': '1', 04:31:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:23 INFO - 'PWD': '/builds/slave/test', 04:31:23 INFO - 'SHELL': '/bin/bash', 04:31:23 INFO - 'SHLVL': '1', 04:31:23 INFO - 'TERM': 'linux', 04:31:23 INFO - 'TMOUT': '86400', 04:31:23 INFO - 'USER': 'cltbld', 04:31:23 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', 04:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:23 INFO - '_': '/tools/buildbot/bin/python'} 04:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:23 INFO - Running setup.py (path:/tmp/pip-4mSEyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:24 INFO - Running setup.py (path:/tmp/pip-zbg7A9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:24 INFO - Running setup.py (path:/tmp/pip-EDXyG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:24 INFO - Running setup.py (path:/tmp/pip-NNiOUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:24 INFO - Running setup.py (path:/tmp/pip-eutmgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:24 INFO - Running setup.py (path:/tmp/pip-_gXc5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:24 INFO - Running setup.py (path:/tmp/pip-3Mo0js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:24 INFO - Running setup.py (path:/tmp/pip-MizbS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:24 INFO - Running setup.py (path:/tmp/pip-I7o0tZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:24 INFO - Running setup.py (path:/tmp/pip-A3P5aO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:24 INFO - Running setup.py (path:/tmp/pip-jDf_qC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:24 INFO - Running setup.py (path:/tmp/pip-FqmZ2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:24 INFO - Running setup.py (path:/tmp/pip-tyRDH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:24 INFO - Running setup.py (path:/tmp/pip-mVUK7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:24 INFO - Running setup.py (path:/tmp/pip-Oue1y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:25 INFO - Running setup.py (path:/tmp/pip-4Gnb01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:25 INFO - Running setup.py (path:/tmp/pip-WNEZbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:31:25 INFO - Running setup.py install for manifestparser 04:31:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:31:25 INFO - Running setup.py install for mozcrash 04:31:25 INFO - Running setup.py install for mozdebug 04:31:25 INFO - Running setup.py install for mozdevice 04:31:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:31:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:31:25 INFO - Running setup.py install for mozfile 04:31:25 INFO - Running setup.py install for mozhttpd 04:31:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:31:25 INFO - Running setup.py install for mozinfo 04:31:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:31:25 INFO - Running setup.py install for mozInstall 04:31:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:31:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:31:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:31:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:31:25 INFO - Running setup.py install for mozleak 04:31:26 INFO - Running setup.py install for mozlog 04:31:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:31:26 INFO - Running setup.py install for moznetwork 04:31:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:31:26 INFO - Running setup.py install for mozprocess 04:31:26 INFO - Running setup.py install for mozprofile 04:31:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:31:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:31:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:31:26 INFO - Running setup.py install for mozrunner 04:31:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:31:26 INFO - Running setup.py install for mozscreenshot 04:31:26 INFO - Running setup.py install for moztest 04:31:26 INFO - Running setup.py install for mozversion 04:31:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:31:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:31:26 INFO - Cleaning up... 04:31:26 INFO - Return code: 0 04:31:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:26 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:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:26 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:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:26 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 0x7f9466846f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0d410>, '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 0x1c0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e7a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', '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:31:26 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:31:26 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:31:26 INFO - Using env: {'DISPLAY': ':0', 04:31:26 INFO - 'HOME': '/home/cltbld', 04:31:26 INFO - 'LANG': 'en_US.UTF-8', 04:31:26 INFO - 'LANGUAGE': 'en_US:en', 04:31:26 INFO - 'LOGNAME': 'cltbld', 04:31:26 INFO - 'MAIL': '/var/mail/cltbld', 04:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:26 INFO - 'MOZ_NO_REMOTE': '1', 04:31:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:26 INFO - 'NO_EM_RESTART': '1', 04:31:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:26 INFO - 'PWD': '/builds/slave/test', 04:31:26 INFO - 'SHELL': '/bin/bash', 04:31:26 INFO - 'SHLVL': '1', 04:31:26 INFO - 'TERM': 'linux', 04:31:26 INFO - 'TMOUT': '86400', 04:31:26 INFO - 'USER': 'cltbld', 04:31:26 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', 04:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:26 INFO - '_': '/tools/buildbot/bin/python'} 04:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:27 INFO - Running setup.py (path:/tmp/pip-jzUPSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:27 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:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:27 INFO - Running setup.py (path:/tmp/pip-FKDhfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:27 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:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:27 INFO - Running setup.py (path:/tmp/pip-ax0_Jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:27 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:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:27 INFO - Running setup.py (path:/tmp/pip-yxSUn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:27 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:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:27 INFO - Running setup.py (path:/tmp/pip-MwnjoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:27 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:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:27 INFO - Running setup.py (path:/tmp/pip-MFYhoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:27 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:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:27 INFO - Running setup.py (path:/tmp/pip-xdsAcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:27 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:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:27 INFO - Running setup.py (path:/tmp/pip-izQtXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:27 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:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:27 INFO - Running setup.py (path:/tmp/pip-tCoVp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:27 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:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:27 INFO - Running setup.py (path:/tmp/pip-0Ypu2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:27 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:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:27 INFO - Running setup.py (path:/tmp/pip-hApOl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:27 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:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:27 INFO - Running setup.py (path:/tmp/pip-qL_7qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:28 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:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:28 INFO - Running setup.py (path:/tmp/pip-fNSv4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:28 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:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:28 INFO - Running setup.py (path:/tmp/pip-w7ocu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:28 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:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:28 INFO - Running setup.py (path:/tmp/pip-_4stWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:28 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:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:28 INFO - Running setup.py (path:/tmp/pip-OC4ZOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:28 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:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:28 INFO - Running setup.py (path:/tmp/pip-NRvOy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:28 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:31:28 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:31:28 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:31:28 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:31:28 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:31:28 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:31:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:28 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:31:28 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:31:28 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:31:28 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:31:28 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:31:28 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:31:31 INFO - Downloading blessings-1.6.tar.gz 04:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:31 INFO - Installing collected packages: blessings 04:31:31 INFO - Running setup.py install for blessings 04:31:31 INFO - Successfully installed blessings 04:31:31 INFO - Cleaning up... 04:31:31 INFO - Return code: 0 04:31:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:31 INFO - Reading from file tmpfile_stdout 04:31:31 INFO - Current package versions: 04:31:31 INFO - argparse == 1.2.1 04:31:31 INFO - blessings == 1.6 04:31:31 INFO - blobuploader == 1.2.4 04:31:31 INFO - docopt == 0.6.1 04:31:31 INFO - manifestparser == 1.1 04:31:31 INFO - mozInstall == 1.12 04:31:31 INFO - mozcrash == 0.17 04:31:31 INFO - mozdebug == 0.1 04:31:31 INFO - mozdevice == 0.48 04:31:31 INFO - mozfile == 1.2 04:31:31 INFO - mozhttpd == 0.7 04:31:31 INFO - mozinfo == 0.9 04:31:31 INFO - mozleak == 0.1 04:31:31 INFO - mozlog == 3.1 04:31:31 INFO - moznetwork == 0.27 04:31:31 INFO - mozprocess == 0.22 04:31:31 INFO - mozprofile == 0.28 04:31:31 INFO - mozrunner == 6.11 04:31:31 INFO - mozscreenshot == 0.1 04:31:31 INFO - mozsystemmonitor == 0.0 04:31:31 INFO - moztest == 0.7 04:31:31 INFO - mozversion == 1.4 04:31:31 INFO - psutil == 3.1.1 04:31:31 INFO - requests == 1.2.3 04:31:31 INFO - wsgiref == 0.1.2 04:31:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:31 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 0x7f9466846f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0d410>, '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 0x1c0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e7a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', '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:31:31 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:31:31 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:31:31 INFO - Using env: {'DISPLAY': ':0', 04:31:31 INFO - 'HOME': '/home/cltbld', 04:31:31 INFO - 'LANG': 'en_US.UTF-8', 04:31:31 INFO - 'LANGUAGE': 'en_US:en', 04:31:31 INFO - 'LOGNAME': 'cltbld', 04:31:31 INFO - 'MAIL': '/var/mail/cltbld', 04:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:31 INFO - 'MOZ_NO_REMOTE': '1', 04:31:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:31 INFO - 'NO_EM_RESTART': '1', 04:31:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:31 INFO - 'PWD': '/builds/slave/test', 04:31:31 INFO - 'SHELL': '/bin/bash', 04:31:31 INFO - 'SHLVL': '1', 04:31:31 INFO - 'TERM': 'linux', 04:31:31 INFO - 'TMOUT': '86400', 04:31:31 INFO - 'USER': 'cltbld', 04:31:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', 04:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:31 INFO - '_': '/tools/buildbot/bin/python'} 04:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:31 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:31:31 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:31:31 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:31:31 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:31:31 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:31:31 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:31:31 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:31:31 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:31:31 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:31:31 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:31:31 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:31:31 INFO - Cleaning up... 04:31:31 INFO - Return code: 0 04:31:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:31 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 0x7f9466846f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0d410>, '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 0x1c0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e7a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', '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:31:31 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:31:31 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:31:31 INFO - Using env: {'DISPLAY': ':0', 04:31:31 INFO - 'HOME': '/home/cltbld', 04:31:31 INFO - 'LANG': 'en_US.UTF-8', 04:31:31 INFO - 'LANGUAGE': 'en_US:en', 04:31:31 INFO - 'LOGNAME': 'cltbld', 04:31:31 INFO - 'MAIL': '/var/mail/cltbld', 04:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:31 INFO - 'MOZ_NO_REMOTE': '1', 04:31:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:31 INFO - 'NO_EM_RESTART': '1', 04:31:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:31 INFO - 'PWD': '/builds/slave/test', 04:31:31 INFO - 'SHELL': '/bin/bash', 04:31:31 INFO - 'SHLVL': '1', 04:31:31 INFO - 'TERM': 'linux', 04:31:31 INFO - 'TMOUT': '86400', 04:31:31 INFO - 'USER': 'cltbld', 04:31:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', 04:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:31 INFO - '_': '/tools/buildbot/bin/python'} 04:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:32 INFO - Downloading/unpacking jsonschema 04:31: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:31: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:31: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:31: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:31: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:31: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:31:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:31:34 INFO - Downloading/unpacking functools32 (from jsonschema) 04:31: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:31: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:31: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:31: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:31: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:31: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:31:34 INFO - Downloading functools32-3.2.3-2.tar.gz 04:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:31:34 INFO - warning: no files found matching '*.txt' 04:31:34 INFO - no previously-included directories found matching 'build' 04:31:34 INFO - no previously-included directories found matching 'dist' 04:31:34 INFO - no previously-included directories found matching '.git*' 04:31:34 INFO - Installing collected packages: jsonschema, functools32 04:31:34 INFO - Running setup.py install for functools32 04:31:34 INFO - warning: no files found matching '*.txt' 04:31:34 INFO - no previously-included directories found matching 'build' 04:31:34 INFO - no previously-included directories found matching 'dist' 04:31:34 INFO - no previously-included directories found matching '.git*' 04:31:34 INFO - Successfully installed jsonschema functools32 04:31:34 INFO - Cleaning up... 04:31:34 INFO - Return code: 0 04:31:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:31: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:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9466846f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0d410>, '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 0x1c0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e7a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', '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:31: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', 'flake8'] in /builds/slave/test/build 04:31: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 flake8 04:31:34 INFO - Using env: {'DISPLAY': ':0', 04:31:34 INFO - 'HOME': '/home/cltbld', 04:31:34 INFO - 'LANG': 'en_US.UTF-8', 04:31:34 INFO - 'LANGUAGE': 'en_US:en', 04:31:34 INFO - 'LOGNAME': 'cltbld', 04:31:34 INFO - 'MAIL': '/var/mail/cltbld', 04:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:34 INFO - 'MOZ_NO_REMOTE': '1', 04:31:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:34 INFO - 'NO_EM_RESTART': '1', 04:31:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:34 INFO - 'PWD': '/builds/slave/test', 04:31:34 INFO - 'SHELL': '/bin/bash', 04:31:34 INFO - 'SHLVL': '1', 04:31:34 INFO - 'TERM': 'linux', 04:31:34 INFO - 'TMOUT': '86400', 04:31:34 INFO - 'USER': 'cltbld', 04:31:34 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', 04:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:34 INFO - '_': '/tools/buildbot/bin/python'} 04:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:34 INFO - Downloading/unpacking flake8 04:31: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:31: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:31: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:31: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:31: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:31: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:31:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:31:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:31: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:31: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:31: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:31: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:31: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:31: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:31:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:31:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:31: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:31: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:31: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:31: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:31: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:31: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:31:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:31: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:31: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:31: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:31: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:31: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:31: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:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:31:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:31:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:31:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:31:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:31:37 INFO - no previously-included directories found matching 'docs/_build' 04:31:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:31:37 INFO - Running setup.py install for pep8 04:31:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:31:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:31:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:31:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:31:37 INFO - no previously-included directories found matching 'docs/_build' 04:31:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:31:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:31:37 INFO - Cleaning up... 04:31:37 INFO - Return code: 0 04:31:37 INFO - Running post-action listener: _resource_record_post_action 04:31:37 INFO - Running post-action listener: _start_resource_monitoring 04:31:37 INFO - Starting resource monitoring. 04:31:37 INFO - ##### 04:31:37 INFO - ##### Running install step. 04:31:37 INFO - ##### 04:31:37 INFO - Running pre-action listener: _resource_record_pre_action 04:31:37 INFO - Running main action method: install 04:31:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:37 INFO - Reading from file tmpfile_stdout 04:31:37 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:37 INFO - Reading from file tmpfile_stdout 04:31:37 INFO - Output received: 04:31:37 INFO - Usage: mozinstall [options] installer 04:31:37 INFO - Options: 04:31:37 INFO - -h, --help show this help message and exit 04:31:37 INFO - -d DEST, --destination=DEST 04:31:37 INFO - Directory to install application into. [default: 04:31:37 INFO - "/builds/slave/test"] 04:31:37 INFO - --app=APP Application being installed. [default: firefox] 04:31:37 INFO - mkdir: /builds/slave/test/build/application 04:31:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:31:53 INFO - Reading from file tmpfile_stdout 04:31:53 INFO - Output received: 04:31:53 INFO - /builds/slave/test/build/application/firefox/firefox 04:31:53 INFO - Running post-action listener: _resource_record_post_action 04:31:53 INFO - ##### 04:31:53 INFO - ##### Running run-tests step. 04:31:53 INFO - ##### 04:31:53 INFO - Running pre-action listener: _resource_record_pre_action 04:31:53 INFO - Running main action method: run_tests 04:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:31:53 INFO - Python 2.7.3 04:31:53 INFO - Return code: 0 04:31:53 INFO - grabbing minidump binary from tooltool 04:31:53 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:31:53 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 0x1c0d410>, '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 0x1c0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:31:53 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:31:53 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:31:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:31:53 INFO - Return code: 0 04:31:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:31:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:31:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:31:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:31:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:31:54 INFO - Return code: 0 04:31:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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:31:54 INFO - Using env: {'DISPLAY': ':0', 04:31:54 INFO - 'HOME': '/home/cltbld', 04:31:54 INFO - 'LANG': 'en_US.UTF-8', 04:31:54 INFO - 'LANGUAGE': 'en_US:en', 04:31:54 INFO - 'LOGNAME': 'cltbld', 04:31:54 INFO - 'MAIL': '/var/mail/cltbld', 04:31:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:31:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:54 INFO - 'MOZ_NO_REMOTE': '1', 04:31:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:54 INFO - 'NO_EM_RESTART': '1', 04:31:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:54 INFO - 'PWD': '/builds/slave/test', 04:31:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:31:54 INFO - 'SHELL': '/bin/bash', 04:31:54 INFO - 'SHLVL': '1', 04:31:54 INFO - 'TERM': 'linux', 04:31:54 INFO - 'TMOUT': '86400', 04:31:54 INFO - 'USER': 'cltbld', 04:31:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868', 04:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:54 INFO - '_': '/tools/buildbot/bin/python'} 04:31:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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:31:54 INFO - mozversion application_buildid: 20160420025335 04:31:54 INFO - mozversion application_changeset: e9088179190a3129cc705ea795e40669c97327d0 04:31:54 INFO - mozversion application_display_name: Nightly 04:31:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:31:54 INFO - mozversion application_name: Firefox 04:31:54 INFO - mozversion application_remotingname: firefox 04:31:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:31:54 INFO - mozversion application_vendor: Mozilla 04:31:54 INFO - mozversion application_version: 48.0a1 04:31:54 INFO - mozversion platform_buildid: 20160420025335 04:31:54 INFO - mozversion platform_changeset: e9088179190a3129cc705ea795e40669c97327d0 04:31:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:31:54 INFO - mozversion platform_version: 48.0a1 04:31:54 INFO - using testdate: 1461151914 04:31:54 INFO - actual date: 1461151914 04:31:54 INFO - starting webserver on 'localhost:57125' 04:31:54 INFO - SUITE-START | Running 2 tests 04:31:54 INFO - TEST-START | dromaeo_css 04:31:54 INFO - operating with platform_type : linux_ 04:31:54 INFO - Initialising browser for dromaeo_css test... 04:31:54 INFO - TEST-INFO | started process 23881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSTjCdO/profile http://localhost:57125/getInfo.html) 04:32:00 INFO - PROCESS | 23881 | __metrics Screen width/height:1600/1200 04:32:00 INFO - PROCESS | 23881 | colorDepth:24 04:32:00 INFO - PROCESS | 23881 | Browser inner width/height: 1024/697 04:32:00 INFO - PROCESS | 23881 | __metrics 04:32:01 ERROR - PROCESS | 23881 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:32:02 INFO - TEST-INFO | 23881: exit 0 04:32:02 INFO - Browser initialized. 04:32:02 INFO - Running cycle 1/1 for dromaeo_css test... 04:32:02 INFO - TEST-INFO | started process 23964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSTjCdO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:14 INFO - PROCESS | 23964 | RSS: Main: 154660864 04:32:14 INFO - PROCESS | 23964 | 04:33:05 INFO - PROCESS | 23964 | 1461151985557 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:35:17 INFO - PROCESS | 23964 | Cycle 1(1): loaded http://localhost:57125/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57125/tests/dromaeo/cssquery-ext.html) 04:35:18 INFO - PROCESS | 23964 | RSS: Main: 263962624 04:35:18 INFO - PROCESS | 23964 | 04:38:20 INFO - PROCESS | 23964 | Cycle 1(1): loaded http://localhost:57125/tests/dromaeo/cssquery-ext.html (next: http://localhost:57125/tests/dromaeo/cssquery-jquery.html) 04:38:21 INFO - PROCESS | 23964 | RSS: Main: 245465088 04:38:21 INFO - PROCESS | 23964 | 04:41:23 INFO - PROCESS | 23964 | Cycle 1(1): loaded http://localhost:57125/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57125/tests/dromaeo/cssquery-mootools.html) 04:41:24 INFO - PROCESS | 23964 | RSS: Main: 239112192 04:41:24 INFO - PROCESS | 23964 | 04:44:26 INFO - PROCESS | 23964 | Cycle 1(1): loaded http://localhost:57125/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57125/tests/dromaeo/cssquery-prototype.html) 04:44:26 INFO - PROCESS | 23964 | RSS: Main: 236568576 04:44:26 INFO - PROCESS | 23964 | 04:47:29 INFO - PROCESS | 23964 | Cycle 1(1): loaded http://localhost:57125/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57125/tests/dromaeo/cssquery-yui.html) 04:47:30 INFO - PROCESS | 23964 | RSS: Main: 215396352 04:47:30 INFO - PROCESS | 23964 | 04:50:33 INFO - PROCESS | 23964 | Cycle 1(1): loaded http://localhost:57125/tests/dromaeo/cssquery-yui.html (next: http://localhost:57125/tests/dromaeo/cssquery-dojo.html) 04:50:33 INFO - PROCESS | 23964 | RSS: Main: 286756864 04:50:33 INFO - PROCESS | 23964 | 04:50:33 INFO - PROCESS | 23964 | __start_tp_report 04:50:33 INFO - PROCESS | 23964 | _x_x_mozilla_page_load 04:50:33 INFO - PROCESS | 23964 | _x_x_mozilla_page_load_details 04:50:33 INFO - PROCESS | 23964 | |i|pagename|runs| 04:50:33 INFO - PROCESS | 23964 | |0;dojo.html;2597.831140975836;2657.0301839828467;2662.188032650041;2671.919842404727;2691.2464509937213;4625.306204069391;4690.202665546857;4696.97651511742;4698.55363740445;4733.597644200243;4734.9763251183695;4797.376341075664;4826.3725715657;4837.226043832988;4839.080574690806;4224.345226489899;4267.978660106695;4286.87139385819;4317.179735850178;4419.270820314644;4324.956750432502;4335.263005289093;4365.4106695596;4369.73781573105;4408.316710909814;4222.366645003243;4232.915341693164;4294.162638285505;4326.307790753496;4356.063446359017;4304.569543045702;4332.566743325642;4338.891527711801;4339.587739164775;4386.451693538308;4281.48622165339;4289;4300.053988122608;4307.956920430787;4350.651947844165;4503.1218912312115;4593.655475839326;4645.5586719261955;4648.628109751212;4693.48371679115;5044.369453818273;5066.695998240118;5068.72122033288;5068.797248110071;5102.719350435725;5040.571551418134;5065.493450654942;5067.721275329855;5068.138416469173;5107.978404319114;4594.196015697273;4732.787024583902;4756.833510827174;4834.154023045953;4848.393950756155;5217.0870097733505;5224;5236.214567814782;5237.711925844039;5243.449437808975;4963.726995015237;4969.180085285887;4973.079980203674;4986.052649996489;5039.21892106724;4913.213885778258;5124.333836601218;5232.686038837682;5237.476252374732;5241.528262456321;5040.168372218543;5043.142665746832;5050.419201791768;5054.671446355975;5063.8480845574695;5044.798208071709;5046.318746969112;5053.9494605054215;5055.393352797688;5088.236764485357;3866.5940076292145;3933.5869733678123;3935.134270460494;3938.7636741795586;4033.274010678106;3470.8719666108614;3490.214701692099;3515.8221995631748;3517.876874309387;3569.1434055826935;4376.343548467692;4386.407834942306;4388.100439409914;4415.249407600716;4435.068635586498;4876.414830220397;5099.056674515226;5103.5406813386235;5109.38687357512;5110.259012443249;4319.33050377192;4331.545187755303;4358.4769827620885;4378.299472084451;4391.099824535962;4557.111363284128;4557.749323787158;4562.634989200856;4589.862304130881;4605.539446055434;4642.86071417858;4795.232762757942;4859.95140048595;4861.756912154378;4863.610911127102;5095.847124586268;5121.436641969455;5128.7179205144075;5141.64008519415;5167.173252279617;4789.544993225638;4791.784369703441;4794.352762377034;4802.519748025309;4855.174620314484;4848.539388758062;4998.4501704813165;5027.673201241908;5047.318611987334;5074.797008119634;5046.369203849519;5054.3176671150395;5063.5695965843315;5088.109580823415;5102.948970510396;4907.533784290486;4907.582855457326;4917.557419832232;4919.0899683558655;4963.776630051584;4692.249240121564;4951.678140920829;4951.77717002743;5024.748762561931;5040.949590504195;4811.422629284508;4816.397950256218;4824.49342818999;4881.560659540658;4895.902081958412;4928.531789479994;4953.306537084739;4958.900821983468;4959;4997.750112494288;4724.338592597108;4823.879403014953;4863.294822250825;4906.730129842893;4911.214205727067 04:50:33 INFO - PROCESS | 23964 | |1;ext.html;575.4561938967674;607.5382709141054;610.438396675059;617.4844005255611;626.6428135962502;34372.828135859316;34794.65205347949;35220.47169292463;35284.64715352846;35310.47034294484;37659;38307.23385532288;38416.42375364372;38459.038524036914;38491.23017539648;7206.531575447605;7588.544687318765;7782.610869456505;7794.844103117963;9484.81030379392;9678.080582344666;9773.804523909517;9774.853377199348;9806.313558050904;9819.26355523335;9733.17268032218;9865.210783137332;9876.209903207726;9890.554925028391;9894.851577226347;9795.608175672964;9859.753506162331;9868.851967220497;9871.60513579463;9876.950615246878;9795.608175672964;9800;9851.901480985242;9913.851292230622;10158.339707918962;37646.43530347019;37743.245135097146;38032.337736358466;38083.23833523314;38083.238335233415;3207.4066297734994;3265.6244531878665;3275.7706960512774;3345.498175273704;3386;28631.28421789451;28981.71018289811;29221.134795551727;29231;29434;3415.3852306584804;3423;3506.561679790026;3633.6729694327637;3636.6363363663686;171794;173792.13103934526;174100;174231.12884435622;174426;46867.531324687;47760.5223947763;47783.761081195065;47784;47834.521654783704;50048;50299.497005030214;50319.49680503221;50419.495805042214;50445.74777126091;13613.659658508419;14108.435662573382;14517.927410362881;14537.345819438151;14540.418383264763;9957.751056223507;10612.469376531297;11030.779384412428;11035.730890947483;11074.944625276983;18491.537711557317;18588.163532641065;18657.720134197996;18688.34590789316;18712.625747484974;6857.862842743117;7041.5775053496955;7090.184628767654;7105.715771369088;7136.607486588184;842.0274582856811;845.2688424512752;924.3021518753299;926.1016813690844;938.8357037518407;28296.575551366746;28381.290467738472;28393.716062839107;28950.855245723636;28954.27614309617;1012.8480727890728;1018.8369860822381;1041.271110222847;1057.5663977769077;1097.1716354152722;14387.352569134415;15123.924380378248;15185.924070379577;15203;15439.768403473958;339251;345163;346847;348071;348259;48593.514064859606;49289.75355123202;49317.75341123271;49330.75334623304;49447.75276123596;1068.124138206663;1180.7189199718403;1226.6197478781605;1277.4762347437506;1278.1117123599195;25152.74847251504;26099.608505872045;26370.472590548467;26696.19911402661;26733;36519.26961460809;36837.26325473422;37113.62886371102;37170.6282937178;37251.25497490089;189376.53117344354;190752.04623976792;190883;191292;191531;22716.886415567817;25152.24543263705;25409.49181016406;25744.8712756435;25836;36927.63072369242;37138.81430592938;37148.25703485861;37238.25523489569;37536;31747.206319841265;31998.840005799822;32150.83924580362;32520.34959300848;32722.50916236306;31707.365852683277;31942.840285798422;32035.519467208476;32227.35545289128;32393.190170245933;34041.31917361688;34758;34935.65064349324;35054.29891402209;35081.64918350784;30214.395712086076;31780.36439271248;31881.20296992501;32010.19974500656;32081;24349.634755478328;24598.631020534347;24614.384640384134;24804.627930581417;24951.750482494943 04:50:33 INFO - PROCESS | 23964 | |2;jquery.html;368.90039689283884;375.2981923802489;389.1671822300276;395.93071212537797;408.31199428962185;15754.684906301867;17034.574135646584;17085.82914170858;17194.140292985332;17223.311067557297;10361.689149325513;16270.674586508263;16753.664926701458;17227.569310767205;17368.392106276282;4657.417822772145;4767.761611919407;4807.975960120212;4815.3258543803895;4816.951830481686;3520.4543295789067;5169.612279079065;5462.535684466805;5486.91769623456;5487.341519017724;5414.485623865746;5426.864328391783;5468.671879687232;5488.807891723791;5489.286392768954;5331.946680533203;5479.561635069185;5484.204790305424;5485.945140548603;5493.560515158818;3412.283420481677;5006.774695138727;5351.973240133813;5354.250404943311;5356.276902618175;12048;12081.45633446497;12132.636020919386;16645.66708665832;19327.51681207981;1841.686913224755;1934.1006432009042;2025.9161348678385;2074.0770357191054;2083.822875055607;9350.953245233799;9549.856752148724;9601.423914565148;9661.372010819274;10603.84094238587;1698.8980661160247;1764.408923010793;1781;1806.1781889240365;1806.837384635389;66254.3374566253;69162.30837691609;69283.45732341401;69778.9533156998;69992.3000769996;9804.901950980542;10081.798364032678;10125.544350504098;10350.585976560853;10748.355098694103;14347.210903400204;14353.282335883165;14469;14469.565913022627;14506;7155.606441645759;7175.712971481186;7216.96391518039;7291.8906216406795;7354.374878135419;6748.426383757337;6753.729850806011;6848.828779280558;6871.106756121772;6873.759418420432;4326.317683036475;4404.427424434803;4414.073044660658;4454.354118652777;4535.501094879561;1721.3372851452282;1758.6861355637845;1783.2153852304943;1798.4245041586828;1852.4624561613828;867.7526904832092;868.9391742578085;874.7681864305964;905.9275257979345;906.850369688994;16242.837571624132;16620.252088656038;16843;16892.493225203263;17266.568335791704;889.3724484193909;893.3701740273092;901.8196360727881;908.7046709819335;915.0620613870835;8957.4177678452;9212.861807072899;9344.813103737888;9581.520923953774;9824.852627210597;308612;319148;320549;432799;433015;81811.5909420461;84344.15655843486;86393;86546.56726716326;87398;975.0834215837091;984.2618036472645;987.7481242283316;993.458565082032;1006.9093781559549;15295.311710973256;15461.5361539154;15500.92249538745;15637.843621564094;15910.920445397698;34912.65087349094;36145.27709445849;36284;36355.818220908724;36402.635973639924;49152.26271605857;49688.75155624199;51631.48368516267;51643.483565163864;51882.48117518928;7540;7549.320561149523;7606.923930760621;7653.425993050655;7661.655225514976;10112.191024718151;11391.54433822671;11659.125565582784;11785.116116291141;11843.111766617365;9643.373180743229;10051.447170405698;10084.647037353658;10085.041921017491;10240.948795255976;6085.57400981927;8262.876056859272;10325.845112323172;10528.420936848546;10529.894701053197;10119.241056920613;10557.366558006544;10675;10681.145508359468;10923.890761092287;7490.5880176588635;7502.212267711811;7626.885596716164;7765.689372425039;8007.759767206993;8967.327450441113;10148.492575371349;10238.33450825694;10251.28241023151;10762.300450470695 04:50:33 INFO - PROCESS | 23964 | |3;mootools.html;1233.6792433967166;1412.8375236847762;1459.3360021190356;1572.5203812837087;1799.4781513361127;7164.6059466729375;7371.963140184305;7408.407327413807;7417.184109747924;7440.702371905124;7240.927590724091;7376.63116844157;7384.2246564110665;7405.259474052592;7407.6296185190795;1927.60484100759;2168.7397512298508;2171.2617709978604;2196.6485362342028;2247.1123906057096;2262.513559584689;2276.35123989663;2285.3600991722346;2287.313805858244;2293.0598454633605;2221.2891874600136;2262.468319944812;2266.954660906781;2267.807236384909;2275.226423016174;1921.2315073970383;2178.4553861534537;2279.8632082074964;2285.714285714286;2287.1651847075696;2205.9448513787124;2227.855189412683;2236.4856083100817;2236.630955892276;2238.0935721033006;7571.205023472567;7627.961860190719;7636.541807491568;7646.350060244886;7647.694092236304;4432.933505997413;4571.428571428572;4578.473475550321;4587.678862479628;4638.1883170445035;3024.6975302469577;3035.741961933238;3106.673799251091;3116.3299890523645;3142.842857857121;954.4130359828655;958.2765012415651;958.3148049144895;971.2424309038961;978.447177344805;10360.585576576928;10522.947385263102;10537.578496860193;10557.788844223149;10572.841407378895;4306.440162778881;4350.521442641307;4450.310201918708;4464.754438505848;4480.843170489017;9065.682701105561;9121.45271283725;9126.406783559047;9141.131592498701;9143.268538516902;4207.158568286355;4767.213409787346;4782.426108866958;4795.832145874878;4821.325014497973;4117.279476091672;4198.706090573692;4199.160167966419;4212.578742125825;4233.280342341809;3605.134767655744;3634.618365071682;3712.3503386907723;3736.3087828751222;3747.138158223624;1253.6176466177903;1254.6361555148906;1273.4778740716263;1281.5322407321446;1289.5744404346542;755.7808235611722;869.1135042256863;898.4025622960788;917.5320586500933;923.0953665407937;5416.431274716177;5472.2338872557875;5518.172274158828;5606.831795046155;5616.775328986876;424.61784394045605;430.9633681137076;450.2323538367076;451.0865497367791;452.31022690397407;3821.3694740368082;3903.941440878389;3932.744371615836;3963.246983073207;4002.139539998856;9228.40015398997;9727.756806079904;9738.902610973799;9740.074692904163;9772.755681108029;9576.329656924088;9732.172765314886;9798.118169364792;9859.507024648883;9867.161291290176;7195.496315257882;7401.740939067106;7464.962675186589;7495.587742674096;7496.962515187498;5226.954609078123;5344.038073146871;5422.9186562202385;5480.780768769205;5510.118381059011;8923.73228803111;8930.419522731001;8931.598078086632;8940.46357218569;9049.457032578066;8874.467531948103;8954.194122529003;9154.359194856295;9170.403923744936;9270.953645231732;6113.724882380215;6572;6784.491163162684;6920.204176519765;7032.2264550898335;7539.773806785805;7632.618369081635;7696.923030769844;7697;7709.884351734616;6814.557053791487;6951.7914462566205;6978.476614254053;7095.467839911924;7095.82260443493;6804.4556435484055;6850.0752398425575;6895.6552172392185;6899.344562266577;6928.411085057625;6106.816795496142;6173.969130154321;6192.907106393318;6411.6153030818305;6413.326600706859;4926.359573255454;4953.678010929278;4975.577075948585;5014.84955451337;5033.245013248042;4964.05682920244;4995.900081998412;5001.574866136273;5021;5062.012907483006 04:50:33 INFO - PROCESS | 23964 | |4;prototype.html;313.2419544701822;315.6322883840326;316.9714725674689;317.8919167483056;322.91281354034425;5078.339815823942;5119.872003199922;5136.589072874171;5141.922871156931;5174.586033117351;5002.499750024996;5058.291839142514;5068.6958782473075;5083.694978301304;5089.618278629099;3748.9437658435145;3814;3930.4890364252606;3940.192260586587;3993.880183594497;3976.389562227288;3992.4610177626087;4001.4598029266112;4006.0786019215598;4010.9598904010877;3770.7737535747806;3957.7427467214684;3959.9208015839667;3962.5046869141356;3968.4047392891152;3819.2170605025904;3928.1161738608585;3939.6014414882875;3941.659835655862;3943.4873466449467;3445.896623101311;3467.9133021674406;3470.410030294831;3471.1322169457635;3490.5636795400574;4873.976464942366;4900.975495122501;4903.338049363326;4905.5094490550655;4907.214845624683;4357.673174511924;4538.092381523676;4593.28804035375;4596.402467679214;4606.769661516911;5277.498637629419;5335.1730481775;5351.331083614548;5354.598405119593;5356.276902618136;3881.8835434936996;3895.2404281165186;3896.3960586109197;3898.493195884545;3902.824372903226;5533.889322213573;5543.861403464905;5614.859628509279;5629.211910332557;5636.887262254732;3931.5871833457077;3947.3092208863336;3976.0855003349393;3990.960090399117;3991.940120898189;4012.3580227163516;4022.8390864365097;4026.4362989181536;4033.8386464541677;4047.7571345719352;4425.296260939562;4540.954590454119;4560.977195114069;4576.107659006462;4591.219492686251;5315.229291752674;5347.3583170019065;5368.1679339702405;5375.75809088592;5376.274202982626;1390.7496650602989;1412.6821465170256;1419.6592817723672;1424.6580820603187;1424.7364237616075;917.9036201198911;937.8546325319586;960.0543464687278;966.1980556138388;991.8115558043949;4723.197056500403;4729.834455794031;4733.195356789354;4736.5500277474275;4765.76171191446;5488.341399032061;5506.944930550643;5519.503244707916;5520.972395138079;5521.613487055867;4519.389882365905;4709.246520556763;4722.95277047232;4733.384659994179;4787.736674482937;2945.617069780915;2956.6399456249937;2969.985150074279;2970.7671316403885;2972.821630702165;5254.947450525522;5267.497938479269;5268.341457317835;5269.473052694777;5280.287161233185;5501.944980550224;5700.201971723962;5726;5728.570357223225;5746.13807928814;5251.713330234117;5264.789408423697;5267.841964741064;5268.367795864521;5272.314599102169;5454.154606036071;5596.104623260258;5604.635698679573;5607;5611.102223644198;5486.1770734388565;5504.587155963399;5509.807156749494;5514.172874068921;5515.944840551543;5228.921566176435;5253.737313134405;5270.525652691276;5273.419923808455;5278.1554951209155;3778.6410291022307;3903.1413089120347;3910.4720862683175;3914.4378615459796;3941.2117576484243;5571.7492712828835;5579.581531385244;5583.994880921311;5584.944150558443;5597.160425936142;5370.248165256945;5391.784328626811;5400.648957817729;5409.29679141709;5410.729463526729;5123.820666276812;5400.62195646301;5403.486668766461;5403.8108666196495;5428.430014848384;5041.546260836542;5302.575793936398;5341.145416733304;5346.861255497676;5360.678359298455;5229.843104706865;5322.38792538863;5432.375276843213;5439.646422982493;5442;5273.762680679302;5284.630075894651;5289.814856480005;5290.100682883842;5296.2320463531805 04:50:33 INFO - PROCESS | 23964 | |5;yui.html;760.5854809129024;790.7271991163046;801.7835184500185;802.0655935834753;804.7424824056301;11813.586524471646;12190.939045304762;12197.756044879097;12198.51205951763;12216.267023978546;11127.666170014912;11195.216334856563;11223.102151827854;11223.326600403982;11231.943840280786;616.7779599344233;758.6055251269337;776.2819392062333;782.026377160436;786.9921300787005;786.8150984518634;795.08168065884;796.5817945578559;798.648594618369;799.2646764976236;827.437342607027;828.2918105020211;828.4408024583412;828.8218033122878;828.8259465512219;646.3568749094658;800.2957397490201;826.0582935453588;826.499967519654;826.8263664630434;612.8712970276247;612.8866159760458;613.3467856732566;616.8118723789242;618.446490391102;11595.246308989888;11648.301101933912;11655.708607284885;11656.650300491;11657.533698652043;12752.681182970407;12798.552050678274;13060.052477845475;13259.668508287274;13284.800727989088;9712.660056897974;9937.5031248438;9951.203903687687;10124.949375253076;10329.741756456073;4143.7720925349095;4177.519585247705;4207.074443622399;4311.61195492404;4358.476982762058;42186.57813421888;43375.56624433747;43550;43594.346084808436;44844.775776121234;9987.600495980225;10013.29906906524;10133.797324053477;10196.184305255561;10422.21833362501;17309.39417120395;17328.48014559565;17378.47864564065;17423.47729568115;18130.637387252445;6919.792406227822;6949.82625434358;6976.860462790817;6988.126484189476;7020.543664661781;3739.476473293741;3768.717346198991;3833.501644786216;3844.154286057063;3844.442555829389;2878.7409133178116;2990.820550766961;2995.5356919677483;3003.1140813460083;3004.819710817358;535.0582973965849;547.5510081733021;549.0254797734054;553.5156737854378;562.4740867289098;552.0146538428885;561.6040691312614;633.4077637409038;649.7888186339459;653.5719103986896;7965.6017199139815;7993.200679931961;8150.184981501802;8202.753917382488;8287.461315014505;475.15185394071415;524.6327570700448;524.9238860365226;541.656048409255;544.8801263721975;3897.162110146332;3899.2396482685604;3970.68234541236;4029.4560234367987;4082.652974497201;44900.775496122966;46887.29669054967;47378.76310618425;47672.28491572629;51228;46100;46558.30162547497;47766.283505747444;49072.75463622659;49863;41399.586004140176;43215.56784432115;44623;44843.77578112089;45050.54949450464;8188.648872936137;8352.874706879524;8393.706220282262;8540.786480338042;8590.570471476527;25326;26677.599836002864;27004.459910802067;28844.711552884204;31375.372492549566;36193;36996.07509812276;37082.44376334411;37846.62153378431;37916.810415947744;9633.566489507848;9777.41335519871;9799.559019843982;9820.067093626094;9877.160441362277;11659.125565582446;12051.69870753203;12081;12092.45583948742;12373.75252494963;10314.742131446774;10663.306885052447;10672.679819605424;10676.092532134855;10738.892611073788;11198.608048718255;11586.478608462809;11630.476628551567;11894.643160705193;11980.700482488008;10872.510737017012;11016.779664406828;11329.051726705076;11400.771984560428;11799.233049851731;9802.460864652512;10002.799944001225;10044.949775251076;10270.845937311096;10303.124234440156;9411.53160293249;9714.611415543583;9777;10170.847437288594;10181.236407269336 04:50:33 INFO - PROCESS | 23964 | __end_tp_report 04:50:33 INFO - PROCESS | 23964 | __start_cc_report 04:50:33 INFO - PROCESS | 23964 | _x_x_mozilla_cycle_collect,1055 04:50:33 INFO - PROCESS | 23964 | __end_cc_report 04:50:33 INFO - PROCESS | 23964 | __startTimestamp1461153033711__endTimestamp 04:50:33 INFO - PROCESS | 23964 | 04:50:33 INFO - PROCESS | 23964 | ------- Summary: start ------- 04:50:33 INFO - PROCESS | 23964 | Number of tests: 6 04:50:33 INFO - PROCESS | 23964 | 04:50:33 INFO - PROCESS | 23964 | [#0] dojo.html Cycles:165 Average:4663.60 Median:4826.37 stddev:525.50 (10.9%) stddev-sans-first:501.51 04:50:33 INFO - PROCESS | 23964 | Values: 2597.8 2657.0 2662.2 2671.9 2691.2 4625.3 4690.2 4697.0 4698.6 4733.6 4735.0 4797.4 4826.4 4837.2 4839.1 4224.3 4268.0 4286.9 4317.2 4419.3 4325.0 4335.3 4365.4 4369.7 4408.3 4222.4 4232.9 4294.2 4326.3 4356.1 4304.6 4332.6 4338.9 4339.6 4386.5 4281.5 4289.0 4300.1 4308.0 4350.7 4503.1 4593.7 4645.6 4648.6 4693.5 5044.4 5066.7 5068.7 5068.8 5102.7 5040.6 5065.5 5067.7 5068.1 5108.0 4594.2 4732.8 4756.8 4834.2 4848.4 5217.1 5224.0 5236.2 5237.7 5243.4 4963.7 4969.2 4973.1 4986.1 5039.2 4913.2 5124.3 5232.7 5237.5 5241.5 5040.2 5043.1 5050.4 5054.7 5063.8 5044.8 5046.3 5053.9 5055.4 5088.2 3866.6 3933.6 3935.1 3938.8 4033.3 3470.9 3490.2 3515.8 3517.9 3569.1 4376.3 4386.4 4388.1 4415.2 4435.1 4876.4 5099.1 5103.5 5109.4 5110.3 4319.3 4331.5 4358.5 4378.3 4391.1 4557.1 4557.7 4562.6 4589.9 4605.5 4642.9 4795.2 4860.0 4861.8 4863.6 5095.8 5121.4 5128.7 5141.6 5167.2 4789.5 4791.8 4794.4 4802.5 4855.2 4848.5 4998.5 5027.7 5047.3 5074.8 5046.4 5054.3 5063.6 5088.1 5102.9 4907.5 4907.6 4917.6 4919.1 4963.8 4692.2 4951.7 4951.8 5024.7 5040.9 4811.4 4816.4 4824.5 4881.6 4895.9 4928.5 4953.3 4958.9 4959.0 4997.8 4724.3 4823.9 4863.3 4906.7 4911.2 04:50:33 INFO - PROCESS | 23964 | 04:50:33 INFO - PROCESS | 23964 | [#1] ext.html Cycles:180 Average:39730.32 Median:346005.00 stddev:65266.97 (18.9%) stddev-sans-first:65383.85 04:50:33 INFO - PROCESS | 23964 | Values: 575.5 607.5 610.4 617.5 626.6 34372.8 34794.7 35220.5 35284.6 35310.5 37659.0 38307.2 38416.4 38459.0 38491.2 7206.5 7588.5 7782.6 7794.8 9484.8 9678.1 9773.8 9774.9 9806.3 9819.3 9733.2 9865.2 9876.2 9890.6 9894.9 9795.6 9859.8 9868.9 9871.6 9877.0 9795.6 9800.0 9851.9 9913.9 10158.3 37646.4 37743.2 38032.3 38083.2 38083.2 3207.4 3265.6 3275.8 3345.5 3386.0 28631.3 28981.7 29221.1 29231.0 29434.0 3415.4 3423.0 3506.6 3633.7 3636.6 171794.0 173792.1 174100.0 174231.1 174426.0 46867.5 47760.5 47783.8 47784.0 47834.5 50048.0 50299.5 50319.5 50419.5 50445.7 13613.7 14108.4 14517.9 14537.3 14540.4 9957.8 10612.5 11030.8 11035.7 11074.9 18491.5 18588.2 18657.7 18688.3 18712.6 6857.9 7041.6 7090.2 7105.7 7136.6 842.0 845.3 924.3 926.1 938.8 28296.6 28381.3 28393.7 28950.9 28954.3 1012.8 1018.8 1041.3 1057.6 1097.2 14387.4 15123.9 15185.9 15203.0 15439.8 339251.0 345163.0 346847.0 348071.0 348259.0 48593.5 49289.8 49317.8 49330.8 49447.8 1068.1 1180.7 1226.6 1277.5 1278.1 25152.7 26099.6 26370.5 26696.2 26733.0 36519.3 36837.3 37113.6 37170.6 37251.3 189376.5 190752.0 190883.0 191292.0 191531.0 22716.9 25152.2 25409.5 25744.9 25836.0 36927.6 37138.8 37148.3 37238.3 37536.0 31747.2 31998.8 32150.8 32520.3 32722.5 31707.4 31942.8 32035.5 32227.4 32393.2 34041.3 34758.0 34935.7 35054.3 35081.6 30214.4 31780.4 31881.2 32010.2 32081.0 24349.6 24598.6 24614.4 24804.6 24951.8 04:50:33 INFO - PROCESS | 23964 | 04:50:33 INFO - PROCESS | 23964 | [#2] jquery.html Cycles:180 Average:23503.79 Median:4409.25 stddev:61097.44 (1385.7%) stddev-sans-first:61244.14 04:50:33 INFO - PROCESS | 23964 | Values: 368.9 375.3 389.2 395.9 408.3 15754.7 17034.6 17085.8 17194.1 17223.3 10361.7 16270.7 16753.7 17227.6 17368.4 4657.4 4767.8 4808.0 4815.3 4817.0 3520.5 5169.6 5462.5 5486.9 5487.3 5414.5 5426.9 5468.7 5488.8 5489.3 5331.9 5479.6 5484.2 5485.9 5493.6 3412.3 5006.8 5352.0 5354.3 5356.3 12048.0 12081.5 12132.6 16645.7 19327.5 1841.7 1934.1 2025.9 2074.1 2083.8 9351.0 9549.9 9601.4 9661.4 10603.8 1698.9 1764.4 1781.0 1806.2 1806.8 66254.3 69162.3 69283.5 69779.0 69992.3 9804.9 10081.8 10125.5 10350.6 10748.4 14347.2 14353.3 14469.0 14469.6 14506.0 7155.6 7175.7 7217.0 7291.9 7354.4 6748.4 6753.7 6848.8 6871.1 6873.8 4326.3 4404.4 4414.1 4454.4 4535.5 1721.3 1758.7 1783.2 1798.4 1852.5 867.8 868.9 874.8 905.9 906.9 16242.8 16620.3 16843.0 16892.5 17266.6 889.4 893.4 901.8 908.7 915.1 8957.4 9212.9 9344.8 9581.5 9824.9 308612.0 319148.0 320549.0 432799.0 433015.0 81811.6 84344.2 86393.0 86546.6 87398.0 975.1 984.3 987.7 993.5 1006.9 15295.3 15461.5 15500.9 15637.8 15910.9 34912.7 36145.3 36284.0 36355.8 36402.6 49152.3 49688.8 51631.5 51643.5 51882.5 7540.0 7549.3 7606.9 7653.4 7661.7 10112.2 11391.5 11659.1 11785.1 11843.1 9643.4 10051.4 10084.6 10085.0 10240.9 6085.6 8262.9 10325.8 10528.4 10529.9 10119.2 10557.4 10675.0 10681.1 10923.9 7490.6 7502.2 7626.9 7765.7 8007.8 8967.3 10148.5 10238.3 10251.3 10762.3 04:50:33 INFO - PROCESS | 23964 | 04:50:33 INFO - PROCESS | 23964 | [#3] mootools.html Cycles:180 Average:5191.56 Median:5285.50 stddev:2861.05 (54.1%) stddev-sans-first:2853.61 04:50:33 INFO - PROCESS | 23964 | Values: 1233.7 1412.8 1459.3 1572.5 1799.5 7164.6 7372.0 7408.4 7417.2 7440.7 7240.9 7376.6 7384.2 7405.3 7407.6 1927.6 2168.7 2171.3 2196.6 2247.1 2262.5 2276.4 2285.4 2287.3 2293.1 2221.3 2262.5 2267.0 2267.8 2275.2 1921.2 2178.5 2279.9 2285.7 2287.2 2205.9 2227.9 2236.5 2236.6 2238.1 7571.2 7628.0 7636.5 7646.4 7647.7 4432.9 4571.4 4578.5 4587.7 4638.2 3024.7 3035.7 3106.7 3116.3 3142.8 954.4 958.3 958.3 971.2 978.4 10360.6 10522.9 10537.6 10557.8 10572.8 4306.4 4350.5 4450.3 4464.8 4480.8 9065.7 9121.5 9126.4 9141.1 9143.3 4207.2 4767.2 4782.4 4795.8 4821.3 4117.3 4198.7 4199.2 4212.6 4233.3 3605.1 3634.6 3712.4 3736.3 3747.1 1253.6 1254.6 1273.5 1281.5 1289.6 755.8 869.1 898.4 917.5 923.1 5416.4 5472.2 5518.2 5606.8 5616.8 424.6 431.0 450.2 451.1 452.3 3821.4 3903.9 3932.7 3963.2 4002.1 9228.4 9727.8 9738.9 9740.1 9772.8 9576.3 9732.2 9798.1 9859.5 9867.2 7195.5 7401.7 7465.0 7495.6 7497.0 5227.0 5344.0 5422.9 5480.8 5510.1 8923.7 8930.4 8931.6 8940.5 9049.5 8874.5 8954.2 9154.4 9170.4 9271.0 6113.7 6572.0 6784.5 6920.2 7032.2 7539.8 7632.6 7696.9 7697.0 7709.9 6814.6 6951.8 6978.5 7095.5 7095.8 6804.5 6850.1 6895.7 6899.3 6928.4 6106.8 6174.0 6192.9 6411.6 6413.3 4926.4 4953.7 4975.6 5014.8 5033.2 4964.1 4995.9 5001.6 5021.0 5062.0 04:50:33 INFO - PROCESS | 23964 | 04:50:33 INFO - PROCESS | 23964 | [#4] prototype.html Cycles:180 Average:4467.79 Median:5086.66 stddev:1297.13 (25.5%) stddev-sans-first:1262.74 04:50:33 INFO - PROCESS | 23964 | Values: 313.2 315.6 317.0 317.9 322.9 5078.3 5119.9 5136.6 5141.9 5174.6 5002.5 5058.3 5068.7 5083.7 5089.6 3748.9 3814.0 3930.5 3940.2 3993.9 3976.4 3992.5 4001.5 4006.1 4011.0 3770.8 3957.7 3959.9 3962.5 3968.4 3819.2 3928.1 3939.6 3941.7 3943.5 3445.9 3467.9 3470.4 3471.1 3490.6 4874.0 4901.0 4903.3 4905.5 4907.2 4357.7 4538.1 4593.3 4596.4 4606.8 5277.5 5335.2 5351.3 5354.6 5356.3 3881.9 3895.2 3896.4 3898.5 3902.8 5533.9 5543.9 5614.9 5629.2 5636.9 3931.6 3947.3 3976.1 3991.0 3991.9 4012.4 4022.8 4026.4 4033.8 4047.8 4425.3 4541.0 4561.0 4576.1 4591.2 5315.2 5347.4 5368.2 5375.8 5376.3 1390.7 1412.7 1419.7 1424.7 1424.7 917.9 937.9 960.1 966.2 991.8 4723.2 4729.8 4733.2 4736.6 4765.8 5488.3 5506.9 5519.5 5521.0 5521.6 4519.4 4709.2 4723.0 4733.4 4787.7 2945.6 2956.6 2970.0 2970.8 2972.8 5254.9 5267.5 5268.3 5269.5 5280.3 5501.9 5700.2 5726.0 5728.6 5746.1 5251.7 5264.8 5267.8 5268.4 5272.3 5454.2 5596.1 5604.6 5607.0 5611.1 5486.2 5504.6 5509.8 5514.2 5515.9 5228.9 5253.7 5270.5 5273.4 5278.2 3778.6 3903.1 3910.5 3914.4 3941.2 5571.7 5579.6 5584.0 5584.9 5597.2 5370.2 5391.8 5400.6 5409.3 5410.7 5123.8 5400.6 5403.5 5403.8 5428.4 5041.5 5302.6 5341.1 5346.9 5360.7 5229.8 5322.4 5432.4 5439.6 5442.0 5273.8 5284.6 5289.8 5290.1 5296.2 04:50:33 INFO - PROCESS | 23964 | 04:50:33 INFO - PROCESS | 23964 | [#5] yui.html Cycles:180 Average:12600.40 Median:23954.24 stddev:13964.45 (58.3%) stddev-sans-first:13975.32 04:50:33 INFO - PROCESS | 23964 | Values: 760.6 790.7 801.8 802.1 804.7 11813.6 12190.9 12197.8 12198.5 12216.3 11127.7 11195.2 11223.1 11223.3 11231.9 616.8 758.6 776.3 782.0 787.0 786.8 795.1 796.6 798.6 799.3 827.4 828.3 828.4 828.8 828.8 646.4 800.3 826.1 826.5 826.8 612.9 612.9 613.3 616.8 618.4 11595.2 11648.3 11655.7 11656.7 11657.5 12752.7 12798.6 13060.1 13259.7 13284.8 9712.7 9937.5 9951.2 10124.9 10329.7 4143.8 4177.5 4207.1 4311.6 4358.5 42186.6 43375.6 43550.0 43594.3 44844.8 9987.6 10013.3 10133.8 10196.2 10422.2 17309.4 17328.5 17378.5 17423.5 18130.6 6919.8 6949.8 6976.9 6988.1 7020.5 3739.5 3768.7 3833.5 3844.2 3844.4 2878.7 2990.8 2995.5 3003.1 3004.8 535.1 547.6 549.0 553.5 562.5 552.0 561.6 633.4 649.8 653.6 7965.6 7993.2 8150.2 8202.8 8287.5 475.2 524.6 524.9 541.7 544.9 3897.2 3899.2 3970.7 4029.5 4082.7 44900.8 46887.3 47378.8 47672.3 51228.0 46100.0 46558.3 47766.3 49072.8 49863.0 41399.6 43215.6 44623.0 44843.8 45050.5 8188.6 8352.9 8393.7 8540.8 8590.6 25326.0 26677.6 27004.5 28844.7 31375.4 36193.0 36996.1 37082.4 37846.6 37916.8 9633.6 9777.4 9799.6 9820.1 9877.2 11659.1 12051.7 12081.0 12092.5 12373.8 10314.7 10663.3 10672.7 10676.1 10738.9 11198.6 11586.5 11630.5 11894.6 11980.7 10872.5 11016.8 11329.1 11400.8 11799.2 9802.5 10002.8 10044.9 10270.8 10303.1 9411.5 9714.6 9777.0 10170.8 10181.2 04:50:33 INFO - PROCESS | 23964 | -------- Summary: end -------- 04:50:33 INFO - PROCESS | 23964 | 04:50:34 INFO - TEST-INFO | 23964: exit 0 04:50:34 INFO - TEST-OK | dromaeo_css | took 1119539ms 04:50:34 INFO - TEST-START | kraken 04:50:34 INFO - operating with platform_type : linux_ 04:50:34 INFO - Initialising browser for kraken test... 04:50:34 INFO - TEST-INFO | started process 24140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyYpFTq/profile http://localhost:57125/getInfo.html) 04:50:38 INFO - PROCESS | 24140 | __metrics Screen width/height:1600/1200 04:50:38 INFO - PROCESS | 24140 | colorDepth:24 04:50:38 INFO - PROCESS | 24140 | Browser inner width/height: 1024/697 04:50:38 INFO - PROCESS | 24140 | __metrics 04:50:40 ERROR - PROCESS | 24140 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:50:41 INFO - TEST-INFO | 24140: exit 0 04:50:41 INFO - Browser initialized. 04:50:41 INFO - Running cycle 1/1 for kraken test... 04:50:41 INFO - TEST-INFO | started process 24222 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyYpFTq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:53 INFO - PROCESS | 24222 | RSS: Main: 155209728 04:50:53 INFO - PROCESS | 24222 | 04:50:55 INFO - PROCESS | 24222 | Cycle 1(1): loaded http://localhost:57125/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57125/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:56 INFO - PROCESS | 24222 | RSS: Main: 210116608 04:50:56 INFO - PROCESS | 24222 | 04:50:59 INFO - PROCESS | 24222 | Cycle 1(1): loaded http://localhost:57125/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57125/tests/kraken/driver.html?testName=audio-dft) 04:51:00 INFO - PROCESS | 24222 | RSS: Main: 195272704 04:51:00 INFO - PROCESS | 24222 | 04:51:03 INFO - PROCESS | 24222 | Cycle 1(1): loaded http://localhost:57125/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57125/tests/kraken/driver.html?testName=audio-fft) 04:51:03 INFO - PROCESS | 24222 | RSS: Main: 266883072 04:51:03 INFO - PROCESS | 24222 | 04:51:06 INFO - PROCESS | 24222 | Cycle 1(1): loaded http://localhost:57125/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57125/tests/kraken/driver.html?testName=audio-oscillator) 04:51:06 INFO - PROCESS | 24222 | RSS: Main: 174903296 04:51:06 INFO - PROCESS | 24222 | 04:51:08 INFO - PROCESS | 24222 | Cycle 1(1): loaded http://localhost:57125/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57125/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:51:09 INFO - PROCESS | 24222 | RSS: Main: 178655232 04:51:09 INFO - PROCESS | 24222 | 04:51:12 INFO - PROCESS | 24222 | Cycle 1(1): loaded http://localhost:57125/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57125/tests/kraken/driver.html?testName=imaging-darkroom) 04:51:13 INFO - PROCESS | 24222 | RSS: Main: 214765568 04:51:13 INFO - PROCESS | 24222 | 04:51:16 INFO - PROCESS | 24222 | Cycle 1(1): loaded http://localhost:57125/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57125/tests/kraken/driver.html?testName=imaging-desaturate) 04:51:17 INFO - PROCESS | 24222 | RSS: Main: 216195072 04:51:17 INFO - PROCESS | 24222 | 04:51:20 INFO - PROCESS | 24222 | Cycle 1(1): loaded http://localhost:57125/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57125/tests/kraken/driver.html?testName=json-parse-financial) 04:51:20 INFO - PROCESS | 24222 | RSS: Main: 216346624 04:51:20 INFO - PROCESS | 24222 | 04:51:22 INFO - PROCESS | 24222 | Cycle 1(1): loaded http://localhost:57125/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57125/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:23 INFO - PROCESS | 24222 | RSS: Main: 204120064 04:51:23 INFO - PROCESS | 24222 | 04:51:25 INFO - PROCESS | 24222 | Cycle 1(1): loaded http://localhost:57125/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57125/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:25 INFO - PROCESS | 24222 | RSS: Main: 205877248 04:51:25 INFO - PROCESS | 24222 | 04:51:27 INFO - PROCESS | 24222 | Cycle 1(1): loaded http://localhost:57125/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57125/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:28 INFO - PROCESS | 24222 | RSS: Main: 218869760 04:51:28 INFO - PROCESS | 24222 | 04:51:31 INFO - PROCESS | 24222 | Cycle 1(1): loaded http://localhost:57125/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57125/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:31 INFO - PROCESS | 24222 | RSS: Main: 223059968 04:51:31 INFO - PROCESS | 24222 | 04:51:34 INFO - PROCESS | 24222 | Cycle 1(1): loaded http://localhost:57125/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57125/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:35 INFO - PROCESS | 24222 | RSS: Main: 216690688 04:51:35 INFO - PROCESS | 24222 | 04:51:37 INFO - PROCESS | 24222 | Cycle 1(1): loaded http://localhost:57125/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57125/tests/kraken/driver.html?testName=ai-astar) 04:51:37 INFO - PROCESS | 24222 | RSS: Main: 280285184 04:51:37 INFO - PROCESS | 24222 | 04:51:37 INFO - PROCESS | 24222 | __start_tp_report 04:51:37 INFO - PROCESS | 24222 | _x_x_mozilla_page_load 04:51:37 INFO - PROCESS | 24222 | _x_x_mozilla_page_load_details 04:51:37 INFO - PROCESS | 24222 | |i|pagename|runs| 04:51:37 INFO - PROCESS | 24222 | |0;ai-astar;111;113;109;112;114;113;102;113;113;113 04:51:37 INFO - PROCESS | 24222 | |1;audio-beat-detection;166;131;161;181;139;158;173;136;187;136 04:51:37 INFO - PROCESS | 24222 | |2;audio-dft;162;160;161;161;162;161;163;162;163;161 04:51:37 INFO - PROCESS | 24222 | |3;audio-fft;73;73;114;111;74;74;77;111;109;73 04:51:37 INFO - PROCESS | 24222 | |4;audio-oscillator;95;95;147;94;97;96;139;94;94;154 04:51:37 INFO - PROCESS | 24222 | |5;imaging-gaussian-blur;119;116;117;118;118;116;117;116;117;117 04:51:37 INFO - PROCESS | 24222 | |6;imaging-darkroom;146;148;146;148;146;148;146;148;146;146 04:51:37 INFO - PROCESS | 24222 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;94 04:51:37 INFO - PROCESS | 24222 | |8;json-parse-financial;63;65;64;64;65;63;65;90;62;62 04:51:37 INFO - PROCESS | 24222 | |9;json-stringify-tinderbox;65;66;65;64;65;65;65;65;73;65 04:51:37 INFO - PROCESS | 24222 | |10;stanford-crypto-aes;79;89;80;79;80;80;80;79;80;80 04:51:37 INFO - PROCESS | 24222 | |11;stanford-crypto-ccm;136;135;137;137;136;133;135;145;169;138 04:51:37 INFO - PROCESS | 24222 | |12;stanford-crypto-pbkdf2;172;175;169;175;175;174;172;176;176;170 04:51:37 INFO - PROCESS | 24222 | |13;stanford-crypto-sha256-iterative;74;70;70;72;71;71;73;72;76;70 04:51:37 INFO - PROCESS | 24222 | __end_tp_report 04:51:37 INFO - PROCESS | 24222 | __start_cc_report 04:51:37 INFO - PROCESS | 24222 | _x_x_mozilla_cycle_collect,1879 04:51:37 INFO - PROCESS | 24222 | __end_cc_report 04:51:37 INFO - PROCESS | 24222 | __startTimestamp1461153097557__endTimestamp 04:51:37 INFO - PROCESS | 24222 | 04:51:37 INFO - PROCESS | 24222 | ------- Summary: start ------- 04:51:37 INFO - PROCESS | 24222 | Number of tests: 14 04:51:37 INFO - PROCESS | 24222 | 04:51:37 INFO - PROCESS | 24222 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.56 (3.2%) stddev-sans-first:3.77 04:51:37 INFO - PROCESS | 24222 | Values: 111.0 113.0 109.0 112.0 114.0 113.0 102.0 113.0 113.0 113.0 04:51:37 INFO - PROCESS | 24222 | 04:51:37 INFO - PROCESS | 24222 | [#1] audio-beat-detection Cycles:10 Average:156.80 Median:163.50 stddev:20.31 (12.4%) stddev-sans-first:21.26 04:51:37 INFO - PROCESS | 24222 | Values: 166.0 131.0 161.0 181.0 139.0 158.0 173.0 136.0 187.0 136.0 04:51:37 INFO - PROCESS | 24222 | 04:51:37 INFO - PROCESS | 24222 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 04:51:37 INFO - PROCESS | 24222 | Values: 162.0 160.0 161.0 161.0 162.0 161.0 163.0 162.0 163.0 161.0 04:51:37 INFO - PROCESS | 24222 | 04:51:37 INFO - PROCESS | 24222 | [#3] audio-fft Cycles:10 Average:88.90 Median:73.00 stddev:19.31 (26.4%) stddev-sans-first:19.60 04:51:37 INFO - PROCESS | 24222 | Values: 73.0 73.0 114.0 111.0 74.0 74.0 77.0 111.0 109.0 73.0 04:51:37 INFO - PROCESS | 24222 | 04:51:37 INFO - PROCESS | 24222 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:94.50 stddev:25.22 (26.7%) stddev-sans-first:26.12 04:51:37 INFO - PROCESS | 24222 | Values: 95.0 95.0 147.0 94.0 97.0 96.0 139.0 94.0 94.0 154.0 04:51:37 INFO - PROCESS | 24222 | 04:51:37 INFO - PROCESS | 24222 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.99 (0.8%) stddev-sans-first:0.78 04:51:37 INFO - PROCESS | 24222 | Values: 119.0 116.0 117.0 118.0 118.0 116.0 117.0 116.0 117.0 117.0 04:51:37 INFO - PROCESS | 24222 | 04:51:37 INFO - PROCESS | 24222 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 04:51:37 INFO - PROCESS | 24222 | Values: 146.0 148.0 146.0 148.0 146.0 148.0 146.0 148.0 146.0 146.0 04:51:37 INFO - PROCESS | 24222 | 04:51:37 INFO - PROCESS | 24222 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 04:51:37 INFO - PROCESS | 24222 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 04:51:37 INFO - PROCESS | 24222 | 04:51:37 INFO - PROCESS | 24222 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:64.50 stddev:8.41 (13.0%) stddev-sans-first:8.83 04:51:37 INFO - PROCESS | 24222 | Values: 63.0 65.0 64.0 64.0 65.0 63.0 65.0 90.0 62.0 62.0 04:51:37 INFO - PROCESS | 24222 | 04:51:37 INFO - PROCESS | 24222 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:65.00 stddev:2.57 (4.0%) stddev-sans-first:2.71 04:51:37 INFO - PROCESS | 24222 | Values: 65.0 66.0 65.0 64.0 65.0 65.0 65.0 65.0 73.0 65.0 04:51:37 INFO - PROCESS | 24222 | 04:51:37 INFO - PROCESS | 24222 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:2.99 (3.7%) stddev-sans-first:3.11 04:51:37 INFO - PROCESS | 24222 | Values: 79.0 89.0 80.0 79.0 80.0 80.0 80.0 79.0 80.0 80.0 04:51:37 INFO - PROCESS | 24222 | 04:51:37 INFO - PROCESS | 24222 | [#11] stanford-crypto-ccm Cycles:10 Average:140.10 Median:137.00 stddev:10.64 (7.8%) stddev-sans-first:11.18 04:51:37 INFO - PROCESS | 24222 | Values: 136.0 135.0 137.0 137.0 136.0 133.0 135.0 145.0 169.0 138.0 04:51:37 INFO - PROCESS | 24222 | 04:51:37 INFO - PROCESS | 24222 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:175.00 stddev:2.50 (1.4%) stddev-sans-first:2.60 04:51:37 INFO - PROCESS | 24222 | Values: 172.0 175.0 169.0 175.0 175.0 174.0 172.0 176.0 176.0 170.0 04:51:37 INFO - PROCESS | 24222 | 04:51:37 INFO - PROCESS | 24222 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.00 stddev:1.97 (2.7%) stddev-sans-first:1.94 04:51:37 INFO - PROCESS | 24222 | Values: 74.0 70.0 70.0 72.0 71.0 71.0 73.0 72.0 76.0 70.0 04:51:37 INFO - PROCESS | 24222 | -------- Summary: end -------- 04:51:37 INFO - PROCESS | 24222 | 04:51:38 INFO - TEST-INFO | 24222: exit 0 04:51:38 INFO - TEST-OK | kraken | took 64138ms 04:51:38 INFO - SUITE-END | took 1183s 04:51:38 INFO - Completed test suite (00:19:43) 04:51:38 INFO - javascript benchmark 04:51:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2597.831140975836, 2657.0301839828467, 2662.188032650041, 2671.919842404727, 2691.2464509937213, 4625.306204069391, 4690.202665546857, 4696.97651511742, 4698.55363740445, 4733.597644200243, 4734.9763251183695, 4797.376341075664, 4826.3725715657, 4837.226043832988, 4839.080574690806, 4224.345226489899, 4267.978660106695, 4286.87139385819, 4317.179735850178, 4419.270820314644, 4324.956750432502, 4335.263005289093, 4365.4106695596, 4369.73781573105, 4408.316710909814, 4222.366645003243, 4232.915341693164, 4294.162638285505, 4326.307790753496, 4356.063446359017, 4304.569543045702, 4332.566743325642, 4338.891527711801, 4339.587739164775, 4386.451693538308, 4281.48622165339, 4289.0, 4300.053988122608, 4307.956920430787, 4350.651947844165, 4503.1218912312115, 4593.655475839326, 4645.5586719261955, 4648.628109751212, 4693.48371679115, 5044.369453818273, 5066.695998240118, 5068.72122033288, 5068.797248110071, 5102.719350435725, 5040.571551418134, 5065.493450654942, 5067.721275329855, 5068.138416469173, 5107.978404319114, 4594.196015697273, 4732.787024583902, 4756.833510827174, 4834.154023045953, 4848.393950756155, 5217.0870097733505, 5224.0, 5236.214567814782, 5237.711925844039, 5243.449437808975, 4963.726995015237, 4969.180085285887, 4973.079980203674, 4986.052649996489, 5039.21892106724, 4913.213885778258, 5124.333836601218, 5232.686038837682, 5237.476252374732, 5241.528262456321, 5040.168372218543, 5043.142665746832, 5050.419201791768, 5054.671446355975, 5063.8480845574695, 5044.798208071709, 5046.318746969112, 5053.9494605054215, 5055.393352797688, 5088.236764485357, 3866.5940076292145, 3933.5869733678123, 3935.134270460494, 3938.7636741795586, 4033.274010678106, 3470.8719666108614, 3490.214701692099, 3515.8221995631748, 3517.876874309387, 3569.1434055826935, 4376.343548467692, 4386.407834942306, 4388.100439409914, 4415.249407600716, 4435.068635586498, 4876.414830220397, 5099.056674515226, 5103.5406813386235, 5109.38687357512, 5110.259012443249, 4319.33050377192, 4331.545187755303, 4358.4769827620885, 4378.299472084451, 4391.099824535962, 4557.111363284128, 4557.749323787158, 4562.634989200856, 4589.862304130881, 4605.539446055434, 4642.86071417858, 4795.232762757942, 4859.95140048595, 4861.756912154378, 4863.610911127102, 5095.847124586268, 5121.436641969455, 5128.7179205144075, 5141.64008519415, 5167.173252279617, 4789.544993225638, 4791.784369703441, 4794.352762377034, 4802.519748025309, 4855.174620314484, 4848.539388758062, 4998.4501704813165, 5027.673201241908, 5047.318611987334, 5074.797008119634, 5046.369203849519, 5054.3176671150395, 5063.5695965843315, 5088.109580823415, 5102.948970510396, 4907.533784290486, 4907.582855457326, 4917.557419832232, 4919.0899683558655, 4963.776630051584, 4692.249240121564, 4951.678140920829, 4951.77717002743, 5024.748762561931, 5040.949590504195, 4811.422629284508, 4816.397950256218, 4824.49342818999, 4881.560659540658, 4895.902081958412, 4928.531789479994, 4953.306537084739, 4958.900821983468, 4959.0, 4997.750112494288, 4724.338592597108, 4823.879403014953, 4863.294822250825, 4906.730129842893, 4911.214205727067], "value": 4628.211990572084, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.4561938967674, 607.5382709141054, 610.438396675059, 617.4844005255611, 626.6428135962502, 34372.828135859316, 34794.65205347949, 35220.47169292463, 35284.64715352846, 35310.47034294484, 37659.0, 38307.23385532288, 38416.42375364372, 38459.038524036914, 38491.23017539648, 7206.531575447605, 7588.544687318765, 7782.610869456505, 7794.844103117963, 9484.81030379392, 9678.080582344666, 9773.804523909517, 9774.853377199348, 9806.313558050904, 9819.26355523335, 9733.17268032218, 9865.210783137332, 9876.209903207726, 9890.554925028391, 9894.851577226347, 9795.608175672964, 9859.753506162331, 9868.851967220497, 9871.60513579463, 9876.950615246878, 9795.608175672964, 9800.0, 9851.901480985242, 9913.851292230622, 10158.339707918962, 37646.43530347019, 37743.245135097146, 38032.337736358466, 38083.23833523314, 38083.238335233415, 3207.4066297734994, 3265.6244531878665, 3275.7706960512774, 3345.498175273704, 3386.0, 28631.28421789451, 28981.71018289811, 29221.134795551727, 29231.0, 29434.0, 3415.3852306584804, 3423.0, 3506.561679790026, 3633.6729694327637, 3636.6363363663686, 171794.0, 173792.13103934526, 174100.0, 174231.12884435622, 174426.0, 46867.531324687, 47760.5223947763, 47783.761081195065, 47784.0, 47834.521654783704, 50048.0, 50299.497005030214, 50319.49680503221, 50419.495805042214, 50445.74777126091, 13613.659658508419, 14108.435662573382, 14517.927410362881, 14537.345819438151, 14540.418383264763, 9957.751056223507, 10612.469376531297, 11030.779384412428, 11035.730890947483, 11074.944625276983, 18491.537711557317, 18588.163532641065, 18657.720134197996, 18688.34590789316, 18712.625747484974, 6857.862842743117, 7041.5775053496955, 7090.184628767654, 7105.715771369088, 7136.607486588184, 842.0274582856811, 845.2688424512752, 924.3021518753299, 926.1016813690844, 938.8357037518407, 28296.575551366746, 28381.290467738472, 28393.716062839107, 28950.855245723636, 28954.27614309617, 1012.8480727890728, 1018.8369860822381, 1041.271110222847, 1057.5663977769077, 1097.1716354152722, 14387.352569134415, 15123.924380378248, 15185.924070379577, 15203.0, 15439.768403473958, 339251.0, 345163.0, 346847.0, 348071.0, 348259.0, 48593.514064859606, 49289.75355123202, 49317.75341123271, 49330.75334623304, 49447.75276123596, 1068.124138206663, 1180.7189199718403, 1226.6197478781605, 1277.4762347437506, 1278.1117123599195, 25152.74847251504, 26099.608505872045, 26370.472590548467, 26696.19911402661, 26733.0, 36519.26961460809, 36837.26325473422, 37113.62886371102, 37170.6282937178, 37251.25497490089, 189376.53117344354, 190752.04623976792, 190883.0, 191292.0, 191531.0, 22716.886415567817, 25152.24543263705, 25409.49181016406, 25744.8712756435, 25836.0, 36927.63072369242, 37138.81430592938, 37148.25703485861, 37238.25523489569, 37536.0, 31747.206319841265, 31998.840005799822, 32150.83924580362, 32520.34959300848, 32722.50916236306, 31707.365852683277, 31942.840285798422, 32035.519467208476, 32227.35545289128, 32393.190170245933, 34041.31917361688, 34758.0, 34935.65064349324, 35054.29891402209, 35081.64918350784, 30214.395712086076, 31780.36439271248, 31881.20296992501, 32010.19974500656, 32081.0, 24349.634755478328, 24598.631020534347, 24614.384640384134, 24804.627930581417, 24951.750482494943], "value": 17131.2370986467, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.90039689283884, 375.2981923802489, 389.1671822300276, 395.93071212537797, 408.31199428962185, 15754.684906301867, 17034.574135646584, 17085.82914170858, 17194.140292985332, 17223.311067557297, 10361.689149325513, 16270.674586508263, 16753.664926701458, 17227.569310767205, 17368.392106276282, 4657.417822772145, 4767.761611919407, 4807.975960120212, 4815.3258543803895, 4816.951830481686, 3520.4543295789067, 5169.612279079065, 5462.535684466805, 5486.91769623456, 5487.341519017724, 5414.485623865746, 5426.864328391783, 5468.671879687232, 5488.807891723791, 5489.286392768954, 5331.946680533203, 5479.561635069185, 5484.204790305424, 5485.945140548603, 5493.560515158818, 3412.283420481677, 5006.774695138727, 5351.973240133813, 5354.250404943311, 5356.276902618175, 12048.0, 12081.45633446497, 12132.636020919386, 16645.66708665832, 19327.51681207981, 1841.686913224755, 1934.1006432009042, 2025.9161348678385, 2074.0770357191054, 2083.822875055607, 9350.953245233799, 9549.856752148724, 9601.423914565148, 9661.372010819274, 10603.84094238587, 1698.8980661160247, 1764.408923010793, 1781.0, 1806.1781889240365, 1806.837384635389, 66254.3374566253, 69162.30837691609, 69283.45732341401, 69778.9533156998, 69992.3000769996, 9804.901950980542, 10081.798364032678, 10125.544350504098, 10350.585976560853, 10748.355098694103, 14347.210903400204, 14353.282335883165, 14469.0, 14469.565913022627, 14506.0, 7155.606441645759, 7175.712971481186, 7216.96391518039, 7291.8906216406795, 7354.374878135419, 6748.426383757337, 6753.729850806011, 6848.828779280558, 6871.106756121772, 6873.759418420432, 4326.317683036475, 4404.427424434803, 4414.073044660658, 4454.354118652777, 4535.501094879561, 1721.3372851452282, 1758.6861355637845, 1783.2153852304943, 1798.4245041586828, 1852.4624561613828, 867.7526904832092, 868.9391742578085, 874.7681864305964, 905.9275257979345, 906.850369688994, 16242.837571624132, 16620.252088656038, 16843.0, 16892.493225203263, 17266.568335791704, 889.3724484193909, 893.3701740273092, 901.8196360727881, 908.7046709819335, 915.0620613870835, 8957.4177678452, 9212.861807072899, 9344.813103737888, 9581.520923953774, 9824.852627210597, 308612.0, 319148.0, 320549.0, 432799.0, 433015.0, 81811.5909420461, 84344.15655843486, 86393.0, 86546.56726716326, 87398.0, 975.0834215837091, 984.2618036472645, 987.7481242283316, 993.458565082032, 1006.9093781559549, 15295.311710973256, 15461.5361539154, 15500.92249538745, 15637.843621564094, 15910.920445397698, 34912.65087349094, 36145.27709445849, 36284.0, 36355.818220908724, 36402.635973639924, 49152.26271605857, 49688.75155624199, 51631.48368516267, 51643.483565163864, 51882.48117518928, 7540.0, 7549.320561149523, 7606.923930760621, 7653.425993050655, 7661.655225514976, 10112.191024718151, 11391.54433822671, 11659.125565582784, 11785.116116291141, 11843.111766617365, 9643.373180743229, 10051.447170405698, 10084.647037353658, 10085.041921017491, 10240.948795255976, 6085.57400981927, 8262.876056859272, 10325.845112323172, 10528.420936848546, 10529.894701053197, 10119.241056920613, 10557.366558006544, 10675.0, 10681.145508359468, 10923.890761092287, 7490.5880176588635, 7502.212267711811, 7626.885596716164, 7765.689372425039, 8007.759767206993, 8967.327450441113, 10148.492575371349, 10238.33450825694, 10251.28241023151, 10762.300450470695], "value": 8097.061887746687, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1233.6792433967166, 1412.8375236847762, 1459.3360021190356, 1572.5203812837087, 1799.4781513361127, 7164.6059466729375, 7371.963140184305, 7408.407327413807, 7417.184109747924, 7440.702371905124, 7240.927590724091, 7376.63116844157, 7384.2246564110665, 7405.259474052592, 7407.6296185190795, 1927.60484100759, 2168.7397512298508, 2171.2617709978604, 2196.6485362342028, 2247.1123906057096, 2262.513559584689, 2276.35123989663, 2285.3600991722346, 2287.313805858244, 2293.0598454633605, 2221.2891874600136, 2262.468319944812, 2266.954660906781, 2267.807236384909, 2275.226423016174, 1921.2315073970383, 2178.4553861534537, 2279.8632082074964, 2285.714285714286, 2287.1651847075696, 2205.9448513787124, 2227.855189412683, 2236.4856083100817, 2236.630955892276, 2238.0935721033006, 7571.205023472567, 7627.961860190719, 7636.541807491568, 7646.350060244886, 7647.694092236304, 4432.933505997413, 4571.428571428572, 4578.473475550321, 4587.678862479628, 4638.1883170445035, 3024.6975302469577, 3035.741961933238, 3106.673799251091, 3116.3299890523645, 3142.842857857121, 954.4130359828655, 958.2765012415651, 958.3148049144895, 971.2424309038961, 978.447177344805, 10360.585576576928, 10522.947385263102, 10537.578496860193, 10557.788844223149, 10572.841407378895, 4306.440162778881, 4350.521442641307, 4450.310201918708, 4464.754438505848, 4480.843170489017, 9065.682701105561, 9121.45271283725, 9126.406783559047, 9141.131592498701, 9143.268538516902, 4207.158568286355, 4767.213409787346, 4782.426108866958, 4795.832145874878, 4821.325014497973, 4117.279476091672, 4198.706090573692, 4199.160167966419, 4212.578742125825, 4233.280342341809, 3605.134767655744, 3634.618365071682, 3712.3503386907723, 3736.3087828751222, 3747.138158223624, 1253.6176466177903, 1254.6361555148906, 1273.4778740716263, 1281.5322407321446, 1289.5744404346542, 755.7808235611722, 869.1135042256863, 898.4025622960788, 917.5320586500933, 923.0953665407937, 5416.431274716177, 5472.2338872557875, 5518.172274158828, 5606.831795046155, 5616.775328986876, 424.61784394045605, 430.9633681137076, 450.2323538367076, 451.0865497367791, 452.31022690397407, 3821.3694740368082, 3903.941440878389, 3932.744371615836, 3963.246983073207, 4002.139539998856, 9228.40015398997, 9727.756806079904, 9738.902610973799, 9740.074692904163, 9772.755681108029, 9576.329656924088, 9732.172765314886, 9798.118169364792, 9859.507024648883, 9867.161291290176, 7195.496315257882, 7401.740939067106, 7464.962675186589, 7495.587742674096, 7496.962515187498, 5226.954609078123, 5344.038073146871, 5422.9186562202385, 5480.780768769205, 5510.118381059011, 8923.73228803111, 8930.419522731001, 8931.598078086632, 8940.46357218569, 9049.457032578066, 8874.467531948103, 8954.194122529003, 9154.359194856295, 9170.403923744936, 9270.953645231732, 6113.724882380215, 6572.0, 6784.491163162684, 6920.204176519765, 7032.2264550898335, 7539.773806785805, 7632.618369081635, 7696.923030769844, 7697.0, 7709.884351734616, 6814.557053791487, 6951.7914462566205, 6978.476614254053, 7095.467839911924, 7095.82260443493, 6804.4556435484055, 6850.0752398425575, 6895.6552172392185, 6899.344562266577, 6928.411085057625, 6106.816795496142, 6173.969130154321, 6192.907106393318, 6411.6153030818305, 6413.326600706859, 4926.359573255454, 4953.678010929278, 4975.577075948585, 5014.84955451337, 5033.245013248042, 4964.05682920244, 4995.900081998412, 5001.574866136273, 5021.0, 5062.012907483006], "value": 4147.08179121103, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.2419544701822, 315.6322883840326, 316.9714725674689, 317.8919167483056, 322.91281354034425, 5078.339815823942, 5119.872003199922, 5136.589072874171, 5141.922871156931, 5174.586033117351, 5002.499750024996, 5058.291839142514, 5068.6958782473075, 5083.694978301304, 5089.618278629099, 3748.9437658435145, 3814.0, 3930.4890364252606, 3940.192260586587, 3993.880183594497, 3976.389562227288, 3992.4610177626087, 4001.4598029266112, 4006.0786019215598, 4010.9598904010877, 3770.7737535747806, 3957.7427467214684, 3959.9208015839667, 3962.5046869141356, 3968.4047392891152, 3819.2170605025904, 3928.1161738608585, 3939.6014414882875, 3941.659835655862, 3943.4873466449467, 3445.896623101311, 3467.9133021674406, 3470.410030294831, 3471.1322169457635, 3490.5636795400574, 4873.976464942366, 4900.975495122501, 4903.338049363326, 4905.5094490550655, 4907.214845624683, 4357.673174511924, 4538.092381523676, 4593.28804035375, 4596.402467679214, 4606.769661516911, 5277.498637629419, 5335.1730481775, 5351.331083614548, 5354.598405119593, 5356.276902618136, 3881.8835434936996, 3895.2404281165186, 3896.3960586109197, 3898.493195884545, 3902.824372903226, 5533.889322213573, 5543.861403464905, 5614.859628509279, 5629.211910332557, 5636.887262254732, 3931.5871833457077, 3947.3092208863336, 3976.0855003349393, 3990.960090399117, 3991.940120898189, 4012.3580227163516, 4022.8390864365097, 4026.4362989181536, 4033.8386464541677, 4047.7571345719352, 4425.296260939562, 4540.954590454119, 4560.977195114069, 4576.107659006462, 4591.219492686251, 5315.229291752674, 5347.3583170019065, 5368.1679339702405, 5375.75809088592, 5376.274202982626, 1390.7496650602989, 1412.6821465170256, 1419.6592817723672, 1424.6580820603187, 1424.7364237616075, 917.9036201198911, 937.8546325319586, 960.0543464687278, 966.1980556138388, 991.8115558043949, 4723.197056500403, 4729.834455794031, 4733.195356789354, 4736.5500277474275, 4765.76171191446, 5488.341399032061, 5506.944930550643, 5519.503244707916, 5520.972395138079, 5521.613487055867, 4519.389882365905, 4709.246520556763, 4722.95277047232, 4733.384659994179, 4787.736674482937, 2945.617069780915, 2956.6399456249937, 2969.985150074279, 2970.7671316403885, 2972.821630702165, 5254.947450525522, 5267.497938479269, 5268.341457317835, 5269.473052694777, 5280.287161233185, 5501.944980550224, 5700.201971723962, 5726.0, 5728.570357223225, 5746.13807928814, 5251.713330234117, 5264.789408423697, 5267.841964741064, 5268.367795864521, 5272.314599102169, 5454.154606036071, 5596.104623260258, 5604.635698679573, 5607.0, 5611.102223644198, 5486.1770734388565, 5504.587155963399, 5509.807156749494, 5514.172874068921, 5515.944840551543, 5228.921566176435, 5253.737313134405, 5270.525652691276, 5273.419923808455, 5278.1554951209155, 3778.6410291022307, 3903.1413089120347, 3910.4720862683175, 3914.4378615459796, 3941.2117576484243, 5571.7492712828835, 5579.581531385244, 5583.994880921311, 5584.944150558443, 5597.160425936142, 5370.248165256945, 5391.784328626811, 5400.648957817729, 5409.29679141709, 5410.729463526729, 5123.820666276812, 5400.62195646301, 5403.486668766461, 5403.8108666196495, 5428.430014848384, 5041.546260836542, 5302.575793936398, 5341.145416733304, 5346.861255497676, 5360.678359298455, 5229.843104706865, 5322.38792538863, 5432.375276843213, 5439.646422982493, 5442.0, 5273.762680679302, 5284.630075894651, 5289.814856480005, 5290.100682883842, 5296.2320463531805], "value": 4059.8452307694374, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.5854809129024, 790.7271991163046, 801.7835184500185, 802.0655935834753, 804.7424824056301, 11813.586524471646, 12190.939045304762, 12197.756044879097, 12198.51205951763, 12216.267023978546, 11127.666170014912, 11195.216334856563, 11223.102151827854, 11223.326600403982, 11231.943840280786, 616.7779599344233, 758.6055251269337, 776.2819392062333, 782.026377160436, 786.9921300787005, 786.8150984518634, 795.08168065884, 796.5817945578559, 798.648594618369, 799.2646764976236, 827.437342607027, 828.2918105020211, 828.4408024583412, 828.8218033122878, 828.8259465512219, 646.3568749094658, 800.2957397490201, 826.0582935453588, 826.499967519654, 826.8263664630434, 612.8712970276247, 612.8866159760458, 613.3467856732566, 616.8118723789242, 618.446490391102, 11595.246308989888, 11648.301101933912, 11655.708607284885, 11656.650300491, 11657.533698652043, 12752.681182970407, 12798.552050678274, 13060.052477845475, 13259.668508287274, 13284.800727989088, 9712.660056897974, 9937.5031248438, 9951.203903687687, 10124.949375253076, 10329.741756456073, 4143.7720925349095, 4177.519585247705, 4207.074443622399, 4311.61195492404, 4358.476982762058, 42186.57813421888, 43375.56624433747, 43550.0, 43594.346084808436, 44844.775776121234, 9987.600495980225, 10013.29906906524, 10133.797324053477, 10196.184305255561, 10422.21833362501, 17309.39417120395, 17328.48014559565, 17378.47864564065, 17423.47729568115, 18130.637387252445, 6919.792406227822, 6949.82625434358, 6976.860462790817, 6988.126484189476, 7020.543664661781, 3739.476473293741, 3768.717346198991, 3833.501644786216, 3844.154286057063, 3844.442555829389, 2878.7409133178116, 2990.820550766961, 2995.5356919677483, 3003.1140813460083, 3004.819710817358, 535.0582973965849, 547.5510081733021, 549.0254797734054, 553.5156737854378, 562.4740867289098, 552.0146538428885, 561.6040691312614, 633.4077637409038, 649.7888186339459, 653.5719103986896, 7965.6017199139815, 7993.200679931961, 8150.184981501802, 8202.753917382488, 8287.461315014505, 475.15185394071415, 524.6327570700448, 524.9238860365226, 541.656048409255, 544.8801263721975, 3897.162110146332, 3899.2396482685604, 3970.68234541236, 4029.4560234367987, 4082.652974497201, 44900.775496122966, 46887.29669054967, 47378.76310618425, 47672.28491572629, 51228.0, 46100.0, 46558.30162547497, 47766.283505747444, 49072.75463622659, 49863.0, 41399.586004140176, 43215.56784432115, 44623.0, 44843.77578112089, 45050.54949450464, 8188.648872936137, 8352.874706879524, 8393.706220282262, 8540.786480338042, 8590.570471476527, 25326.0, 26677.599836002864, 27004.459910802067, 28844.711552884204, 31375.372492549566, 36193.0, 36996.07509812276, 37082.44376334411, 37846.62153378431, 37916.810415947744, 9633.566489507848, 9777.41335519871, 9799.559019843982, 9820.067093626094, 9877.160441362277, 11659.125565582446, 12051.69870753203, 12081.0, 12092.45583948742, 12373.75252494963, 10314.742131446774, 10663.306885052447, 10672.679819605424, 10676.092532134855, 10738.892611073788, 11198.608048718255, 11586.478608462809, 11630.476628551567, 11894.643160705193, 11980.700482488008, 10872.510737017012, 11016.779664406828, 11329.051726705076, 11400.771984560428, 11799.233049851731, 9802.460864652512, 10002.799944001225, 10044.949775251076, 10270.845937311096, 10303.124234440156, 9411.53160293249, 9714.611415543583, 9777.0, 10170.847437288594, 10181.236407269336], "value": 5960.556848610093, "unit": "score"}], "name": "dromaeo_css", "value": 6331.6810143336115, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 109.0, 112.0, 114.0, 113.0, 102.0, 113.0, 113.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 131.0, 161.0, 181.0, 139.0, 158.0, 173.0, 136.0, 187.0, 136.0], "value": 156.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 161.0, 162.0, 161.0, 163.0, 162.0, 163.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 114.0, 111.0, 74.0, 74.0, 77.0, 111.0, 109.0, 73.0], "value": 88.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 147.0, 94.0, 97.0, 96.0, 139.0, 94.0, 94.0, 154.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 116.0, 117.0, 118.0, 118.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 148.0, 146.0, 148.0, 146.0, 148.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 65.0, 63.0, 65.0, 90.0, 62.0, 62.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 73.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 89.0, 80.0, 79.0, 80.0, 80.0, 80.0, 79.0, 80.0, 80.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 137.0, 137.0, 136.0, 133.0, 135.0, 145.0, 169.0, 138.0], "value": 140.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 175.0, 169.0, 175.0, 175.0, 174.0, 172.0, 176.0, 176.0, 170.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 70.0, 72.0, 71.0, 71.0, 73.0, 72.0, 76.0, 70.0], "value": 71.9, "unit": "score"}], "name": "kraken", "value": 1586.1, "alertThreshold": 2.0}]} 04:51:38 INFO - Return code: 0 04:51:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:51:38 ERROR - # TBPL SUCCESS # 04:51:38 INFO - Running post-action listener: _resource_record_post_action 04:51:38 INFO - Running post-run listener: _resource_record_post_run 04:51:39 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 529231872; Read time: 16; Write time: 601288 04:51:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234500096; Read time: 0; Write time: 349652 04:51:39 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294731776; Read time: 16; Write time: 251636 04:51:39 INFO - Running post-run listener: _upload_blobber_files 04:51:39 INFO - Blob upload gear active. 04:51:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:39 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:51:39 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:51:39 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:51:40 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:51:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:51:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:41 INFO - (blobuploader) - INFO - Done attempting. 04:51:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:51:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:51:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:41 INFO - (blobuploader) - INFO - Done attempting. 04:51:41 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:41 INFO - Return code: 0 04:51:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:51:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/393ae11be1d8b03895d41f703d76940730e83e131a9b86f2663f438a69a9e2d4d35f5e58cc4e66aa588c842b1c842fdbb0de2422e858efae3c527d009aef46fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f25d2e0e3f2dcb042f757908ead66de3bd0707f7de91656eef2170fc40818b120706fa9a98d7881917d8644ebbc6d9574264e1521647b6d6621aca9066e8ba39"} 04:51:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:51:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:51:41 INFO - Contents: 04:51:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/393ae11be1d8b03895d41f703d76940730e83e131a9b86f2663f438a69a9e2d4d35f5e58cc4e66aa588c842b1c842fdbb0de2422e858efae3c527d009aef46fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f25d2e0e3f2dcb042f757908ead66de3bd0707f7de91656eef2170fc40818b120706fa9a98d7881917d8644ebbc6d9574264e1521647b6d6621aca9066e8ba39"} 04:51:41 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:41 INFO - Copying logs to upload dir... 04:51:41 INFO - mkdir: /builds/slave/test/build/upload/logs 04:51:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.613416 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-20 04:51:41.877761) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 04:51:41.881543) ========= 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=eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/393ae11be1d8b03895d41f703d76940730e83e131a9b86f2663f438a69a9e2d4d35f5e58cc4e66aa588c842b1c842fdbb0de2422e858efae3c527d009aef46fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f25d2e0e3f2dcb042f757908ead66de3bd0707f7de91656eef2170fc40818b120706fa9a98d7881917d8644ebbc6d9574264e1521647b6d6621aca9066e8ba39"} build_url:https://queue.taskcluster.net/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/fVG_5l5wQOC3HQbg11N51Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/393ae11be1d8b03895d41f703d76940730e83e131a9b86f2663f438a69a9e2d4d35f5e58cc4e66aa588c842b1c842fdbb0de2422e858efae3c527d009aef46fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f25d2e0e3f2dcb042f757908ead66de3bd0707f7de91656eef2170fc40818b120706fa9a98d7881917d8644ebbc6d9574264e1521647b6d6621aca9066e8ba39"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 04:51:41.909365) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:51:41.909707) ========= 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=eca2ab57546de7b41f256b19000001ef-1461151858.843449-2077404868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004387 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:51:41.995014) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 04:51:41.995347) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 04:51:41.995656) ========= ========= Total master_lag: 0.18 =========