builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1461061877.22 results: success (0) buildid: 20160419024446 builduid: 206e70f1227742a590c9adc83b0f7e6c revision: 4992cef658a669d514b3469c4b4449ac5826359d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 03:31:17.223206) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 03:31:17.223615) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 03:31:17.223891) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 03:31:17.244058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:31:17.244395) ========= 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=232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 03:31:17-- 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% 224M=0s 2016-04-19 03:31:18 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.246688 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:31:17.504029) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:31:17.507407) ========= 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=232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014748 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:31:17.557789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:31:17.558152) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4992cef658a669d514b3469c4b4449ac5826359d --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 4992cef658a669d514b3469c4b4449ac5826359d --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=232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 03:31:18,192 truncating revision to first 12 chars 2016-04-19 03:31:18,192 Setting DEBUG logging. 2016-04-19 03:31:18,192 attempt 1/10 2016-04-19 03:31:18,192 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4992cef658a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 03:31:18,531 unpacking tar archive at: fx-team-4992cef658a6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618468 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:31:18.193214) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 03:31:18.193538) ========= script_repo_revision: 4992cef658a669d514b3469c4b4449ac5826359d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 03:31:18.193945) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 03:31:18.194243) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 03:31:18.207567) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-19 03:31:18.207898) ========= /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=232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:18 INFO - MultiFileLogger online at 20160419 03:31:18 in /builds/slave/test 03:31:18 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 03:31:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:31:18 INFO - {'append_to_log': False, 03:31:18 INFO - 'base_work_dir': '/builds/slave/test', 03:31:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:31:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:31:18 INFO - 'branch': 'Fx-Team-Non-PGO', 03:31:18 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:18 INFO - 'config_files': ('talos/linux_config.py',), 03:31:18 INFO - 'default_actions': ('clobber', 03:31:18 INFO - 'read-buildbot-config', 03:31:18 INFO - 'download-and-extract', 03:31:18 INFO - 'populate-webroot', 03:31:18 INFO - 'create-virtualenv', 03:31:18 INFO - 'install', 03:31:18 INFO - 'run-tests'), 03:31:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:18 INFO - 'download_minidump_stackwalk': True, 03:31:18 INFO - 'download_symbols': 'ondemand', 03:31:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:18 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:18 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:18 INFO - 'installer_path': 'installer.exe', 03:31:18 INFO - 'log_level': 'info', 03:31:18 INFO - 'log_name': 'talos', 03:31:18 INFO - 'log_to_console': True, 03:31:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:18 INFO - 'opt_config_files': (), 03:31:18 INFO - 'pip_index': False, 03:31:18 INFO - 'sps_profile': False, 03:31:18 INFO - 'sps_profile_interval': 0, 03:31:18 INFO - 'suite': 'dromaeojs', 03:31:18 INFO - 'system_bits': '32', 03:31:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:18 INFO - 'title': 'talos-linux64-ix-025', 03:31:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:18 INFO - 'use_talos_json': True, 03:31:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:31:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:18 INFO - 'work_dir': 'build'} 03:31:18 INFO - ##### 03:31:18 INFO - ##### Running clobber step. 03:31:18 INFO - ##### 03:31:18 INFO - Running pre-action listener: _resource_record_pre_action 03:31:18 INFO - Running main action method: clobber 03:31:18 INFO - rmtree: /builds/slave/test/build 03:31:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:31:19 INFO - Running post-action listener: _resource_record_post_action 03:31:19 INFO - ##### 03:31:19 INFO - ##### Running read-buildbot-config step. 03:31:19 INFO - ##### 03:31:19 INFO - Running pre-action listener: _resource_record_pre_action 03:31:19 INFO - Running main action method: read_buildbot_config 03:31:19 INFO - Using buildbot properties: 03:31:19 INFO - { 03:31:19 INFO - "project": "", 03:31:19 INFO - "product": "firefox", 03:31:19 INFO - "script_repo_revision": "production", 03:31:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:31:19 INFO - "repository": "", 03:31:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:31:19 INFO - "buildid": "20160419024446", 03:31:19 INFO - "pgo_build": "False", 03:31:19 INFO - "basedir": "/builds/slave/test", 03:31:19 INFO - "buildnumber": 1660, 03:31:19 INFO - "slavename": "talos-linux64-ix-025", 03:31:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:31:19 INFO - "platform": "ubuntu64_hw", 03:31:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:31:19 INFO - "branch": "fx-team", 03:31:19 INFO - "repo_path": "integration/fx-team", 03:31:19 INFO - "revision": "4992cef658a669d514b3469c4b4449ac5826359d", 03:31:19 INFO - "stage_platform": "linux64", 03:31:19 INFO - "builduid": "206e70f1227742a590c9adc83b0f7e6c", 03:31:19 INFO - "slavebuilddir": "test" 03:31:19 INFO - } 03:31:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 03:31:19 INFO - Running post-action listener: _resource_record_post_action 03:31:19 INFO - ##### 03:31:19 INFO - ##### Running download-and-extract step. 03:31:19 INFO - ##### 03:31:19 INFO - Running pre-action listener: _resource_record_pre_action 03:31:19 INFO - Running main action method: download_and_extract 03:31:19 INFO - mkdir: /builds/slave/test/build/tests 03:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:19 INFO - https://queue.taskcluster.net/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:31:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:31:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:31:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/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 03:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/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 03:31:20 INFO - Downloaded 1361 bytes. 03:31:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:31:20 INFO - Using the following test package requirements: 03:31:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:31:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:31:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:31:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:20 INFO - u'jsshell-linux-x86_64.zip'], 03:31:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:31:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:31:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:31:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:31:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:31:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:31:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03: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')]} 03:31:20 INFO - https://queue.taskcluster.net/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:31:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:31:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/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 03:31:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/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 03:31:21 INFO - Downloaded 22209599 bytes. 03:31:21 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'] 03:31:21 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 03:31:22 INFO - Return code: 0 03:31:22 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 03:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:22 INFO - https://queue.taskcluster.net/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:31:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:31:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/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 03:31:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/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 03:31:25 INFO - Downloaded 22209599 bytes. 03:31:25 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'] 03:31:25 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 03:31:26 INFO - Return code: 0 03: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')]} 03:31:26 INFO - https://queue.taskcluster.net/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:31:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:31:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:31:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/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 03:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/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 03:31:27 INFO - Downloaded 10845952 bytes. 03:31:27 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'] 03:31:27 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 03:31:27 INFO - Return code: 0 03:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:27 INFO - https://queue.taskcluster.net/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:31:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:31:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:31:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/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 03:31:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pk5PpSdjT_OINrr5cnZMrg/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 03:31:31 INFO - Downloaded 54448433 bytes. 03:31:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:31:31 INFO - mkdir: /builds/slave/test/properties 03:31:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:31 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:31 INFO - Contents: 03:31:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:31:32 INFO - Running post-action listener: _resource_record_post_action 03:31:32 INFO - Running post-action listener: set_extra_try_arguments 03:31:32 INFO - ##### 03:31:32 INFO - ##### Running populate-webroot step. 03:31:32 INFO - ##### 03:31:32 INFO - Running pre-action listener: _resource_record_pre_action 03:31:32 INFO - Running main action method: populate_webroot 03:31:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:32 INFO - '--tppagecycles', 03:31:32 INFO - '7'], 03:31:32 INFO - 'tests': ['tsvgm']}}, 03:31:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:31:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:31:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:31:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:31:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:31:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:32 INFO - 'talos_options': ['--disable-e10s'], 03:31:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:32 INFO - 'talos_options': ['--disable-e10s'], 03:31:32 INFO - 'tests': ['damp', 'tps']}, 03:31:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:32 INFO - 'tests': ['damp', 'tps']}, 03:31:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:31:32 INFO - 'tests': ['dromaeo_dom']}, 03:31:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:31:32 INFO - 'tests': ['a11yr', 03:31:32 INFO - 'ts_paint', 03:31:32 INFO - 'tpaint', 03:31:32 INFO - 'sessionrestore', 03:31:32 INFO - 'sessionrestore_no_auto_restore', 03:31:32 INFO - 'tabpaint']}, 03:31:32 INFO - 'other-e10s': {'tests': ['a11yr', 03:31:32 INFO - 'ts_paint', 03:31:32 INFO - 'tpaint', 03:31:32 INFO - 'sessionrestore', 03:31:32 INFO - 'sessionrestore_no_auto_restore', 03:31:32 INFO - 'tabpaint']}, 03:31:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:31:32 INFO - 'ts_paint', 03:31:32 INFO - 'tpaint', 03:31:32 INFO - 'sessionrestore', 03:31:32 INFO - 'sessionrestore_no_auto_restore', 03:31:32 INFO - 'tabpaint']}, 03:31:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:31:32 INFO - 'ts_paint', 03:31:32 INFO - 'tpaint', 03:31:32 INFO - 'sessionrestore', 03:31:32 INFO - 'sessionrestore_no_auto_restore', 03:31:32 INFO - 'tabpaint']}, 03:31:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:31:32 INFO - 'tests': ['a11yr', 03:31:32 INFO - 'ts_paint', 03:31:32 INFO - 'tpaint', 03:31:32 INFO - 'sessionrestore', 03:31:32 INFO - 'sessionrestore_no_auto_restore', 03:31:32 INFO - 'tabpaint']}, 03:31:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:31:32 INFO - 'tests': ['a11yr', 03:31:32 INFO - 'ts_paint', 03:31:32 INFO - 'tpaint', 03:31:32 INFO - 'sessionrestore', 03:31:32 INFO - 'sessionrestore_no_auto_restore', 03:31:32 INFO - 'tabpaint']}, 03:31:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:31:32 INFO - 'tests': ['tsvgx', 03:31:32 INFO - 'tsvgr_opacity', 03:31:32 INFO - 'tart', 03:31:32 INFO - 'tscrollx', 03:31:32 INFO - 'cart']}, 03:31:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:31:32 INFO - 'tsvgr_opacity', 03:31:32 INFO - 'tart', 03:31:32 INFO - 'tscrollx', 03:31:32 INFO - 'cart']}, 03:31:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:32 INFO - 'talos_options': ['--disable-e10s'], 03:31:32 INFO - 'tests': ['tp5o']}, 03:31:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:32 INFO - 'tests': ['tp5o']}, 03:31:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:32 INFO - 'talos_options': ['--disable-e10s', 03:31:32 INFO - '--xperf_path', 03:31:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:32 INFO - 'tests': ['tp5n']}, 03:31:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:32 INFO - 'talos_options': ['--xperf_path', 03:31:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:32 INFO - 'tests': ['tp5n']}}, 03:31:32 INFO - 'talos.zip': {'path': '', 03:31:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:32 INFO - Running post-action listener: _resource_record_post_action 03:31:32 INFO - ##### 03:31:32 INFO - ##### Running create-virtualenv step. 03:31:32 INFO - ##### 03:31:32 INFO - Running pre-action listener: _resource_record_pre_action 03:31:32 INFO - Running main action method: create_virtualenv 03:31:32 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:31:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:32 INFO - Using real prefix '/usr' 03:31:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:32 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:34 INFO - Installing pip.................done. 03:31:34 INFO - Return code: 0 03:31:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3211542f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03: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', 'pip>=1.5'] in /builds/slave/test/build 03: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 pip>=1.5 03:31:34 INFO - Using env: {'DISPLAY': ':0', 03:31:34 INFO - 'HOME': '/home/cltbld', 03:31:34 INFO - 'LANG': 'en_US.UTF-8', 03:31:34 INFO - 'LANGUAGE': 'en_US:en', 03:31:34 INFO - 'LOGNAME': 'cltbld', 03:31:34 INFO - 'MAIL': '/var/mail/cltbld', 03:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:34 INFO - 'MOZ_NO_REMOTE': '1', 03:31:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:34 INFO - 'NO_EM_RESTART': '1', 03:31:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:34 INFO - 'PWD': '/builds/slave/test', 03:31:34 INFO - 'SHELL': '/bin/bash', 03:31:34 INFO - 'SHLVL': '1', 03:31:34 INFO - 'TERM': 'linux', 03:31:34 INFO - 'TMOUT': '86400', 03:31:34 INFO - 'USER': 'cltbld', 03:31:34 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 03:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:34 INFO - '_': '/tools/buildbot/bin/python'} 03:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:31:34 INFO - Cleaning up... 03:31:34 INFO - Return code: 0 03:31:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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', '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 0x7f3211542f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03: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', 'psutil>=0.7.1'] in /builds/slave/test/build 03: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 psutil>=0.7.1 03:31:34 INFO - Using env: {'DISPLAY': ':0', 03:31:34 INFO - 'HOME': '/home/cltbld', 03:31:34 INFO - 'LANG': 'en_US.UTF-8', 03:31:34 INFO - 'LANGUAGE': 'en_US:en', 03:31:34 INFO - 'LOGNAME': 'cltbld', 03:31:34 INFO - 'MAIL': '/var/mail/cltbld', 03:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:34 INFO - 'MOZ_NO_REMOTE': '1', 03:31:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:34 INFO - 'NO_EM_RESTART': '1', 03:31:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:34 INFO - 'PWD': '/builds/slave/test', 03:31:34 INFO - 'SHELL': '/bin/bash', 03:31:34 INFO - 'SHLVL': '1', 03:31:34 INFO - 'TERM': 'linux', 03:31:34 INFO - 'TMOUT': '86400', 03:31:34 INFO - 'USER': 'cltbld', 03:31:34 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 03:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:34 INFO - '_': '/tools/buildbot/bin/python'} 03:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:35 INFO - Downloading/unpacking psutil>=0.7.1 03:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:37 INFO - Installing collected packages: psutil 03:31:37 INFO - Running setup.py install for psutil 03:31:37 INFO - building 'psutil._psutil_linux' extension 03:31:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:31:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:31:37 INFO - building 'psutil._psutil_posix' extension 03:31:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:31:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:31:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:37 INFO - Successfully installed psutil 03:31:37 INFO - Cleaning up... 03:31:37 INFO - Return code: 0 03:31:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:37 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 0x7f3211542f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:31:37 INFO - Using env: {'DISPLAY': ':0', 03:31:37 INFO - 'HOME': '/home/cltbld', 03:31:37 INFO - 'LANG': 'en_US.UTF-8', 03:31:37 INFO - 'LANGUAGE': 'en_US:en', 03:31:37 INFO - 'LOGNAME': 'cltbld', 03:31:37 INFO - 'MAIL': '/var/mail/cltbld', 03:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:37 INFO - 'MOZ_NO_REMOTE': '1', 03:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:37 INFO - 'NO_EM_RESTART': '1', 03:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:37 INFO - 'PWD': '/builds/slave/test', 03:31:37 INFO - 'SHELL': '/bin/bash', 03:31:37 INFO - 'SHLVL': '1', 03:31:37 INFO - 'TERM': 'linux', 03:31:37 INFO - 'TMOUT': '86400', 03:31:37 INFO - 'USER': 'cltbld', 03:31:37 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 03:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:37 INFO - '_': '/tools/buildbot/bin/python'} 03:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03: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 03: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 03: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 03: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 03: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 03: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 03:31:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:31:39 INFO - Installing collected packages: mozsystemmonitor 03:31:39 INFO - Running setup.py install for mozsystemmonitor 03:31:39 INFO - Successfully installed mozsystemmonitor 03:31:39 INFO - Cleaning up... 03:31:39 INFO - Return code: 0 03:31:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:39 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 0x7f3211542f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:31:39 INFO - Using env: {'DISPLAY': ':0', 03:31:39 INFO - 'HOME': '/home/cltbld', 03:31:39 INFO - 'LANG': 'en_US.UTF-8', 03:31:39 INFO - 'LANGUAGE': 'en_US:en', 03:31:39 INFO - 'LOGNAME': 'cltbld', 03:31:39 INFO - 'MAIL': '/var/mail/cltbld', 03:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:39 INFO - 'MOZ_NO_REMOTE': '1', 03:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:39 INFO - 'NO_EM_RESTART': '1', 03:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:39 INFO - 'PWD': '/builds/slave/test', 03:31:39 INFO - 'SHELL': '/bin/bash', 03:31:39 INFO - 'SHLVL': '1', 03:31:39 INFO - 'TERM': 'linux', 03:31:39 INFO - 'TMOUT': '86400', 03:31:39 INFO - 'USER': 'cltbld', 03:31:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 03:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:39 INFO - '_': '/tools/buildbot/bin/python'} 03:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:40 INFO - Downloading/unpacking blobuploader==1.2.4 03:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:41 INFO - Downloading blobuploader-1.2.4.tar.gz 03:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:31:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:31:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:42 INFO - Downloading docopt-0.6.1.tar.gz 03:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:31:42 INFO - Installing collected packages: blobuploader, requests, docopt 03:31:42 INFO - Running setup.py install for blobuploader 03:31:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:31:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:31:42 INFO - Running setup.py install for requests 03:31:43 INFO - Running setup.py install for docopt 03:31:43 INFO - Successfully installed blobuploader requests docopt 03:31:43 INFO - Cleaning up... 03:31:43 INFO - Return code: 0 03:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:43 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 0x7f3211542f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:31:43 INFO - Using env: {'DISPLAY': ':0', 03:31:43 INFO - 'HOME': '/home/cltbld', 03:31:43 INFO - 'LANG': 'en_US.UTF-8', 03:31:43 INFO - 'LANGUAGE': 'en_US:en', 03:31:43 INFO - 'LOGNAME': 'cltbld', 03:31:43 INFO - 'MAIL': '/var/mail/cltbld', 03:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:43 INFO - 'MOZ_NO_REMOTE': '1', 03:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:43 INFO - 'NO_EM_RESTART': '1', 03:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:43 INFO - 'PWD': '/builds/slave/test', 03:31:43 INFO - 'SHELL': '/bin/bash', 03:31:43 INFO - 'SHLVL': '1', 03:31:43 INFO - 'TERM': 'linux', 03:31:43 INFO - 'TMOUT': '86400', 03:31:43 INFO - 'USER': 'cltbld', 03:31:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 03:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:43 INFO - '_': '/tools/buildbot/bin/python'} 03:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:43 INFO - Running setup.py (path:/tmp/pip-_v6UhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:43 INFO - Running setup.py (path:/tmp/pip-ZTSuCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:43 INFO - Running setup.py (path:/tmp/pip-eP3Lsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:43 INFO - Running setup.py (path:/tmp/pip-Jm5a94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:43 INFO - Running setup.py (path:/tmp/pip-YPTvEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:43 INFO - Running setup.py (path:/tmp/pip-XpNafP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:43 INFO - Running setup.py (path:/tmp/pip-pTjl8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:44 INFO - Running setup.py (path:/tmp/pip-g27O5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:44 INFO - Running setup.py (path:/tmp/pip-Sf0fYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:44 INFO - Running setup.py (path:/tmp/pip-Iqx_Py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:44 INFO - Running setup.py (path:/tmp/pip-a4bxG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:44 INFO - Running setup.py (path:/tmp/pip-qH3WIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:44 INFO - Running setup.py (path:/tmp/pip-pux3Jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:44 INFO - Running setup.py (path:/tmp/pip-6BGZQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:44 INFO - Running setup.py (path:/tmp/pip-460Kjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:44 INFO - Running setup.py (path:/tmp/pip-3YBxWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:44 INFO - Running setup.py (path:/tmp/pip-DTnRdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:31:44 INFO - Running setup.py install for manifestparser 03:31:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:31:44 INFO - Running setup.py install for mozcrash 03:31:44 INFO - Running setup.py install for mozdebug 03:31:45 INFO - Running setup.py install for mozdevice 03:31:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Running setup.py install for mozfile 03:31:45 INFO - Running setup.py install for mozhttpd 03:31:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Running setup.py install for mozinfo 03:31:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Running setup.py install for mozInstall 03:31:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Running setup.py install for mozleak 03:31:45 INFO - Running setup.py install for mozlog 03:31:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Running setup.py install for moznetwork 03:31:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Running setup.py install for mozprocess 03:31:45 INFO - Running setup.py install for mozprofile 03:31:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:31:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:31:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:31:46 INFO - Running setup.py install for mozrunner 03:31:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:31:46 INFO - Running setup.py install for mozscreenshot 03:31:46 INFO - Running setup.py install for moztest 03:31:46 INFO - Running setup.py install for mozversion 03:31:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:31:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:31:46 INFO - Cleaning up... 03:31:46 INFO - Return code: 0 03:31:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:46 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 0x7f3211542f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:31:46 INFO - Using env: {'DISPLAY': ':0', 03:31:46 INFO - 'HOME': '/home/cltbld', 03:31:46 INFO - 'LANG': 'en_US.UTF-8', 03:31:46 INFO - 'LANGUAGE': 'en_US:en', 03:31:46 INFO - 'LOGNAME': 'cltbld', 03:31:46 INFO - 'MAIL': '/var/mail/cltbld', 03:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:46 INFO - 'MOZ_NO_REMOTE': '1', 03:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:46 INFO - 'NO_EM_RESTART': '1', 03:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:46 INFO - 'PWD': '/builds/slave/test', 03:31:46 INFO - 'SHELL': '/bin/bash', 03:31:46 INFO - 'SHLVL': '1', 03:31:46 INFO - 'TERM': 'linux', 03:31:46 INFO - 'TMOUT': '86400', 03:31:46 INFO - 'USER': 'cltbld', 03:31:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 03:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:46 INFO - '_': '/tools/buildbot/bin/python'} 03:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:46 INFO - Running setup.py (path:/tmp/pip-X0B1Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:46 INFO - Running setup.py (path:/tmp/pip-hyqwHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:46 INFO - Running setup.py (path:/tmp/pip-NfyNqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:46 INFO - Running setup.py (path:/tmp/pip-bdlfWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:47 INFO - Running setup.py (path:/tmp/pip-YbI57k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:47 INFO - Running setup.py (path:/tmp/pip-ThOuUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:47 INFO - Running setup.py (path:/tmp/pip-lzL_34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:47 INFO - Running setup.py (path:/tmp/pip-JVFiHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:47 INFO - Running setup.py (path:/tmp/pip-v34Dgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:47 INFO - Running setup.py (path:/tmp/pip-uXL_bD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:47 INFO - Running setup.py (path:/tmp/pip-sQaHwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:47 INFO - Running setup.py (path:/tmp/pip-RHKZVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:47 INFO - Running setup.py (path:/tmp/pip-FLBw1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:47 INFO - Running setup.py (path:/tmp/pip-ANx1Dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:47 INFO - Running setup.py (path:/tmp/pip-UZTb_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:47 INFO - Running setup.py (path:/tmp/pip-qFxK2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:47 INFO - Running setup.py (path:/tmp/pip-PE5ATP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:31:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:49 INFO - Downloading blessings-1.6.tar.gz 03:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:31:49 INFO - Installing collected packages: blessings 03:31:49 INFO - Running setup.py install for blessings 03:31:50 INFO - Successfully installed blessings 03:31:50 INFO - Cleaning up... 03:31:50 INFO - Return code: 0 03:31:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:31:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:50 INFO - Reading from file tmpfile_stdout 03:31:50 INFO - Current package versions: 03:31:50 INFO - argparse == 1.2.1 03:31:50 INFO - blessings == 1.6 03:31:50 INFO - blobuploader == 1.2.4 03:31:50 INFO - docopt == 0.6.1 03:31:50 INFO - manifestparser == 1.1 03:31:50 INFO - mozInstall == 1.12 03:31:50 INFO - mozcrash == 0.17 03:31:50 INFO - mozdebug == 0.1 03:31:50 INFO - mozdevice == 0.48 03:31:50 INFO - mozfile == 1.2 03:31:50 INFO - mozhttpd == 0.7 03:31:50 INFO - mozinfo == 0.9 03:31:50 INFO - mozleak == 0.1 03:31:50 INFO - mozlog == 3.1 03:31:50 INFO - moznetwork == 0.27 03:31:50 INFO - mozprocess == 0.22 03:31:50 INFO - mozprofile == 0.28 03:31:50 INFO - mozrunner == 6.11 03:31:50 INFO - mozscreenshot == 0.1 03:31:50 INFO - mozsystemmonitor == 0.0 03:31:50 INFO - moztest == 0.7 03:31:50 INFO - mozversion == 1.4 03:31:50 INFO - psutil == 3.1.1 03:31:50 INFO - requests == 1.2.3 03:31:50 INFO - wsgiref == 0.1.2 03:31:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:50 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 0x7f3211542f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:31:50 INFO - Using env: {'DISPLAY': ':0', 03:31:50 INFO - 'HOME': '/home/cltbld', 03:31:50 INFO - 'LANG': 'en_US.UTF-8', 03:31:50 INFO - 'LANGUAGE': 'en_US:en', 03:31:50 INFO - 'LOGNAME': 'cltbld', 03:31:50 INFO - 'MAIL': '/var/mail/cltbld', 03:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:50 INFO - 'MOZ_NO_REMOTE': '1', 03:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:50 INFO - 'NO_EM_RESTART': '1', 03:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:50 INFO - 'PWD': '/builds/slave/test', 03:31:50 INFO - 'SHELL': '/bin/bash', 03:31:50 INFO - 'SHLVL': '1', 03:31:50 INFO - 'TERM': 'linux', 03:31:50 INFO - 'TMOUT': '86400', 03:31:50 INFO - 'USER': 'cltbld', 03:31:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 03:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:50 INFO - '_': '/tools/buildbot/bin/python'} 03:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:31:50 INFO - Cleaning up... 03:31:50 INFO - Return code: 0 03:31:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:50 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 0x7f3211542f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:31:50 INFO - Using env: {'DISPLAY': ':0', 03:31:50 INFO - 'HOME': '/home/cltbld', 03:31:50 INFO - 'LANG': 'en_US.UTF-8', 03:31:50 INFO - 'LANGUAGE': 'en_US:en', 03:31:50 INFO - 'LOGNAME': 'cltbld', 03:31:50 INFO - 'MAIL': '/var/mail/cltbld', 03:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:50 INFO - 'MOZ_NO_REMOTE': '1', 03:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:50 INFO - 'NO_EM_RESTART': '1', 03:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:50 INFO - 'PWD': '/builds/slave/test', 03:31:50 INFO - 'SHELL': '/bin/bash', 03:31:50 INFO - 'SHLVL': '1', 03:31:50 INFO - 'TERM': 'linux', 03:31:50 INFO - 'TMOUT': '86400', 03:31:50 INFO - 'USER': 'cltbld', 03:31:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 03:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:50 INFO - '_': '/tools/buildbot/bin/python'} 03:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:50 INFO - Downloading/unpacking jsonschema 03:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:31:52 INFO - Downloading/unpacking functools32 (from jsonschema) 03:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:52 INFO - Downloading functools32-3.2.3-2.tar.gz 03:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:31:52 INFO - warning: no files found matching '*.txt' 03:31:52 INFO - no previously-included directories found matching 'build' 03:31:52 INFO - no previously-included directories found matching 'dist' 03:31:52 INFO - no previously-included directories found matching '.git*' 03:31:52 INFO - Installing collected packages: jsonschema, functools32 03:31:53 INFO - Running setup.py install for functools32 03:31:53 INFO - warning: no files found matching '*.txt' 03:31:53 INFO - no previously-included directories found matching 'build' 03:31:53 INFO - no previously-included directories found matching 'dist' 03:31:53 INFO - no previously-included directories found matching '.git*' 03:31:53 INFO - Successfully installed jsonschema functools32 03:31:53 INFO - Cleaning up... 03:31:53 INFO - Return code: 0 03:31:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:53 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 0x7f3211542f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, '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': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:31:53 INFO - Using env: {'DISPLAY': ':0', 03:31:53 INFO - 'HOME': '/home/cltbld', 03:31:53 INFO - 'LANG': 'en_US.UTF-8', 03:31:53 INFO - 'LANGUAGE': 'en_US:en', 03:31:53 INFO - 'LOGNAME': 'cltbld', 03:31:53 INFO - 'MAIL': '/var/mail/cltbld', 03:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:53 INFO - 'MOZ_NO_REMOTE': '1', 03:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:53 INFO - 'NO_EM_RESTART': '1', 03:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:53 INFO - 'PWD': '/builds/slave/test', 03:31:53 INFO - 'SHELL': '/bin/bash', 03:31:53 INFO - 'SHLVL': '1', 03:31:53 INFO - 'TERM': 'linux', 03:31:53 INFO - 'TMOUT': '86400', 03:31:53 INFO - 'USER': 'cltbld', 03:31:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 03:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:53 INFO - '_': '/tools/buildbot/bin/python'} 03:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:53 INFO - Downloading/unpacking flake8 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:31:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:31:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:31:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:56 INFO - no previously-included directories found matching 'docs/_build' 03:31:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:31:56 INFO - Running setup.py install for pep8 03:31:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:56 INFO - no previously-included directories found matching 'docs/_build' 03:31:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:31:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:31:56 INFO - Cleaning up... 03:31:56 INFO - Return code: 0 03:31:56 INFO - Running post-action listener: _resource_record_post_action 03:31:56 INFO - Running post-action listener: _start_resource_monitoring 03:31:56 INFO - Starting resource monitoring. 03:31:56 INFO - ##### 03:31:56 INFO - ##### Running install step. 03:31:56 INFO - ##### 03:31:56 INFO - Running pre-action listener: _resource_record_pre_action 03:31:56 INFO - Running main action method: install 03:31:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:56 INFO - Reading from file tmpfile_stdout 03:31:56 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:31:56 INFO - Reading from file tmpfile_stdout 03:31:56 INFO - Output received: 03:31:56 INFO - Usage: mozinstall [options] installer 03:31:56 INFO - Options: 03:31:56 INFO - -h, --help show this help message and exit 03:31:56 INFO - -d DEST, --destination=DEST 03:31:56 INFO - Directory to install application into. [default: 03:31:56 INFO - "/builds/slave/test"] 03:31:56 INFO - --app=APP Application being installed. [default: firefox] 03:31:56 INFO - mkdir: /builds/slave/test/build/application 03:31:56 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'] 03:31:56 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 03:32:12 INFO - Reading from file tmpfile_stdout 03:32:12 INFO - Output received: 03:32:12 INFO - /builds/slave/test/build/application/firefox/firefox 03:32:12 INFO - Running post-action listener: _resource_record_post_action 03:32:12 INFO - ##### 03:32:12 INFO - ##### Running run-tests step. 03:32:12 INFO - ##### 03:32:12 INFO - Running pre-action listener: _resource_record_pre_action 03:32:12 INFO - Running main action method: run_tests 03:32:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:32:12 INFO - Python 2.7.3 03:32:12 INFO - Return code: 0 03:32:12 INFO - grabbing minidump binary from tooltool 03:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:12 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 0x22ad410>, '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 0x22ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ae7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:32:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:32:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:32:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:12 INFO - Return code: 0 03:32:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:32:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:32:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:32:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:32:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:32:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:32:13 INFO - Return code: 0 03:32:13 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/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:32:13 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/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:32:13 INFO - Using env: {'DISPLAY': ':0', 03:32:13 INFO - 'HOME': '/home/cltbld', 03:32:13 INFO - 'LANG': 'en_US.UTF-8', 03:32:13 INFO - 'LANGUAGE': 'en_US:en', 03:32:13 INFO - 'LOGNAME': 'cltbld', 03:32:13 INFO - 'MAIL': '/var/mail/cltbld', 03:32:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:32:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:13 INFO - 'MOZ_NO_REMOTE': '1', 03:32:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:13 INFO - 'NO_EM_RESTART': '1', 03:32:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:13 INFO - 'PWD': '/builds/slave/test', 03:32:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:32:13 INFO - 'SHELL': '/bin/bash', 03:32:13 INFO - 'SHLVL': '1', 03:32:13 INFO - 'TERM': 'linux', 03:32:13 INFO - 'TMOUT': '86400', 03:32:13 INFO - 'USER': 'cltbld', 03:32:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622', 03:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:13 INFO - '_': '/tools/buildbot/bin/python'} 03:32:13 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/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:32:13 INFO - mozversion application_buildid: 20160419024446 03:32:13 INFO - mozversion application_changeset: 4992cef658a669d514b3469c4b4449ac5826359d 03:32:13 INFO - mozversion application_display_name: Nightly 03:32:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:13 INFO - mozversion application_name: Firefox 03:32:13 INFO - mozversion application_remotingname: firefox 03:32:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:32:13 INFO - mozversion application_vendor: Mozilla 03:32:13 INFO - mozversion application_version: 48.0a1 03:32:13 INFO - mozversion platform_buildid: 20160419024446 03:32:13 INFO - mozversion platform_changeset: 4992cef658a669d514b3469c4b4449ac5826359d 03:32:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:32:13 INFO - mozversion platform_version: 48.0a1 03:32:13 INFO - using testdate: 1461061933 03:32:13 INFO - actual date: 1461061933 03:32:13 INFO - starting webserver on 'localhost:44423' 03:32:13 INFO - SUITE-START | Running 2 tests 03:32:13 INFO - TEST-START | dromaeo_css 03:32:13 INFO - operating with platform_type : linux_ 03:32:13 INFO - Initialising browser for dromaeo_css test... 03:32:13 INFO - TEST-INFO | started process 8219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ufZoz/profile http://localhost:44423/getInfo.html) 03:32:17 INFO - PROCESS | 8219 | __metrics Screen width/height:1600/1200 03:32:17 INFO - PROCESS | 8219 | colorDepth:24 03:32:17 INFO - PROCESS | 8219 | Browser inner width/height: 1024/697 03:32:17 INFO - PROCESS | 8219 | __metrics 03:32:19 ERROR - PROCESS | 8219 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:32:19 INFO - TEST-INFO | 8219: exit 0 03:32:19 INFO - Browser initialized. 03:32:19 INFO - Running cycle 1/1 for dromaeo_css test... 03:32:19 INFO - TEST-INFO | started process 8302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ufZoz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:31 INFO - PROCESS | 8302 | RSS: Main: 154652672 03:32:31 INFO - PROCESS | 8302 | 03:33:23 INFO - PROCESS | 8302 | 1461062003410 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:35:34 INFO - PROCESS | 8302 | Cycle 1(1): loaded http://localhost:44423/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44423/tests/dromaeo/cssquery-ext.html) 03:35:36 INFO - PROCESS | 8302 | RSS: Main: 272003072 03:35:36 INFO - PROCESS | 8302 | 03:38:38 INFO - PROCESS | 8302 | Cycle 1(1): loaded http://localhost:44423/tests/dromaeo/cssquery-ext.html (next: http://localhost:44423/tests/dromaeo/cssquery-jquery.html) 03:38:39 INFO - PROCESS | 8302 | RSS: Main: 234545152 03:38:39 INFO - PROCESS | 8302 | 03:41:41 INFO - PROCESS | 8302 | Cycle 1(1): loaded http://localhost:44423/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44423/tests/dromaeo/cssquery-mootools.html) 03:41:41 INFO - PROCESS | 8302 | RSS: Main: 241115136 03:41:41 INFO - PROCESS | 8302 | 03:44:43 INFO - PROCESS | 8302 | Cycle 1(1): loaded http://localhost:44423/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44423/tests/dromaeo/cssquery-prototype.html) 03:44:44 INFO - PROCESS | 8302 | RSS: Main: 240168960 03:44:44 INFO - PROCESS | 8302 | 03:47:47 INFO - PROCESS | 8302 | Cycle 1(1): loaded http://localhost:44423/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44423/tests/dromaeo/cssquery-yui.html) 03:47:48 INFO - PROCESS | 8302 | RSS: Main: 210571264 03:47:48 INFO - PROCESS | 8302 | 03:50:50 INFO - PROCESS | 8302 | Cycle 1(1): loaded http://localhost:44423/tests/dromaeo/cssquery-yui.html (next: http://localhost:44423/tests/dromaeo/cssquery-dojo.html) 03:50:50 INFO - PROCESS | 8302 | RSS: Main: 286126080 03:50:50 INFO - PROCESS | 8302 | 03:50:50 INFO - PROCESS | 8302 | __start_tp_report 03:50:50 INFO - PROCESS | 8302 | _x_x_mozilla_page_load 03:50:50 INFO - PROCESS | 8302 | _x_x_mozilla_page_load_details 03:50:50 INFO - PROCESS | 8302 | |i|pagename|runs| 03:50:50 INFO - PROCESS | 8302 | |0;dojo.html;2581;2656.78745700344;2670.3858112634107;2681.262652770488;2700.2979225401396;4497.3029180477;4557.498675145735;4568;4573.931391029133;4654.04592058628;4625.144348295567;4633.119707255619;4671.626269898408;4701.529847015297;4701.788419521121;4203.579642035787;4223.32426811711;4264.381664658623;4289.506706728719;4414.359917811916;4332.610065094141;4357.38996540483;4373.037931655047;4376.059147283333;4404.581564751344;4165.812538435777;4165.937510937339;4207.579242075799;4245.57544245573;4251.319788833803;4199.9370009449885;4203.453551038376;4206.705530612859;4213.831446742127;4266.786660666954;4218.493780746299;4224.809883555216;4236.639885609727;4259.488861336628;4272.829086836523;4416.183006143874;4499.10017996402;4561.361409402686;4608.677392582521;4622.884427889296;4975.776090075955;4980.203167493184;5004.649674522785;5024.145895197788;5045.243213517965;4821.397325334333;4958.132326842824;5008.499150084962;5012.448630650625;5026.497350264981;4605.4473463184295;4693.694909830884;4703;4707.105649926503;4707.882302942454;5003.224500202475;5005.649604527648;5005.674631148963;5011.072951503984;5026.597872170218;4823.541763532458;4823.807047718122;4824.324594556765;4827.686200396963;4875.95124048762;4690.226112691368;4915.8033678652455;4964.255361695702;4998;5014.548690617862;4868.196747536687;4879.926801097987;4882.292067650171;4885.09625719236;4937.086638971802;4707.835225767081;4855.44162421319;4861.076395484846;4864.124457597666;4909.926351104737;4116.5060192777055;4165.854195103157;4231.449911511545;4244.957550424518;4246.787660616957;3649.197176621139;3660.816959152032;3662.285854258447;3690.095926498025;3704.9629503705155;4264.445622069111;4268.914621707549;4269.978650106729;4271.786410679453;4308.978455107705;4784.64115191362;4945.208766597327;4997.925031124536;5032.245163225545;5044.520770526794;4259.382389553497;4275.786210689453;4295.4415925929425;4295.8496452624;4335.913281734348;4298.613124818781;4459.620932220732;4460.553944605514;4467.530909254547;4495.213337665896;4644.047970166175;4677.602403795716;4677.836275730333;4716.29255611661;4719.7404142772475;4929.852104436873;4946.579540738933;4947.48051454592;4947.752612369439;4978.925316120333;4555.3850230218495;4671.299305104261;4675;4678.976605116953;4726.054789042274;4846.176150054429;4875.975620121877;4881.58506526935;4889.535494128052;4928.630352723489;4887.486813884491;4905.9018819624125;4923.261510773269;4924.458309585871;4968.602511799119;4652.976735116303;4759.143354196278;4804.855854324376;4820.638452116035;4846.854594362175;4720.575148236675;4735.33705281254;4741.786619602057;4786.44955830084;4795.448523419851;4676.134915040729;4677.345171676036;4686.671932964659;4705.835295764632;4712.50518695532;4666.183417901786;4700.2244629635725;4758.286257061469;4785.760711964318;4862.708237505761;4662.393888794435;4680.7893644786745;4713.057388522378;4715.3869996900185;4741.241401375763 03:50:50 INFO - PROCESS | 8302 | |1;ext.html;554.0525701051203;594.3491876395349;604.4892066204058;612.647727556655;629.4492319220683;33799.83100084499;34213.31573368531;35064.47403288953;35448;35461.2907741845;36795.08012299694;37534.4369834452;37629.24741505168;37657.811710941474;37672.24655506888;7149.642517874112;7510.849783004351;7760.185180556045;7772.65023073963;9494.098060684224;9534.618615255382;9723.902760972405;9727.562259698296;9728.854067188999;9731;9680;9790.706278811647;9801.941592265634;9805.509724513746;9819;9672.56473458696;9769.51152442375;9778.90221097787;9784.070513301225;9786.41281523111;9663.27525435595;9764.462954537568;9768.413895166314;9770.51147442625;10052.045055719695;38308.233835323415;38749.61250387516;38764.41853372202;38806.611933880864;38824.611753882666;2801.1596521043607;2806.5369214079856;2823.745862872351;2871.9712802871913;3167.303193297471;28973.42053158946;29156.854215729;29213.123606291632;29283.121506354844;29382.85308573465;3333.93332133356;3375.6961873431264;3413.641567635387;3442.1738782691973;3482.164280572644;214235.64410889853;215507;215639;216104.99999999843;216461;54875.451245487835;54948.17577736337;55084;55360;55404.44595554074;52319;52349.7382513085;52353.476465235624;52401.47598523966;52434;14154;14804;14838.035527690665;14838.33227504765;14845.183514906785;10084.394936303845;11429.485673144729;11712.355820429959;11805;12073.758524829454;18163.72754408685;18408.35570755017;18417;18422.263109475472;18444;6873.759418420332;7180.1742799578715;7212.71149154028;7302.890456643155;7346;790.426940468156;901.2204443156622;952.64752041745;1010.8231059564694;1029.9742506437249;28305.71694283072;28430.71569284281;29559.704402956126;30626;31273;951.1487218939011;994.9403035817874;1013.4527355228241;1015.3248090020202;1099.741560733227;14280.14319140834;14619.26903654813;14717.632059198391;14932.477363292233;15020.09879407239;328489;332297;334818;335071;335627;48558.51441485611;49429.50570494321;49437.25844112341;49565;49576.752116239186;1146.5356530605118;1188.5721140389453;1274.3437129878305;1284.9871501284867;1298.2729671383865;24567.38581535476;26856.865715671298;27854.721452786023;28283.858580707787;28627;40470.79764601158;41203.38194927019;41254.587454125074;41257;41450;241544;247201;247251;247854;500110;25627.35931601725;26166.215013549623;26358.73641263563;26398.736012639627;26851.194464166107;40147.39778903377;40423.3237199007;41163.794181028905;41335.37996929988;41472.170556589306;34820;34973.65026349704;35097.47353789644;35652.61300176479;35962.64037359593;34652;34866.65133348735;34989;35157.47263790994;35216.47175292424;34518.48222276618;34778.13054673552;34873.30253394867;35423.82288088543;35460.29079418346;29972;31285.530717038808;31414.371712566077;31508.054758357284;31668.04995850128;24582.75417245876;24803.791203847395;24860;25008.624870627318;25029.49941001206 03:50:50 INFO - PROCESS | 8302 | |2;jquery.html;372.821045897969;373.8074891430913;377.5582568394978;378.5155001597956;389.18465814119446;16757.664846703057;17278.2224799884;17661.55846103848;17702.380416685417;17703.29186832525;12177.025837932966;15608.60978475536;16207.189640517956;16222.918885405556;16239.83760162398;4509.90980180397;4640.141573808839;4712.929306060412;4729;4740.407449068866;3427.6915077643007;4589.632829373659;5087.923681144785;5397.811076612319;5417.431169727181;5385.515303622673;5385.542228910528;5394.1908713692865;5415.268938693265;5415.539679127279;5112.744362781865;5382.300300960869;5430.70131142787;5434.510894019557;5439.347278326626;3327.600687917441;5047.293378926953;5286;5372.489613486712;5389.191621256804;12099.274043557414;12212.511499540007;12270.631881043493;13709.657258568515;20343.5931281375;1838.218757028271;1886.9905650471796;1888.9716654250196;1913.4546654203484;2286.1998300594823;8701.825963480758;9065.184133427958;9403.012683668254;9514.666986655433;9596.32825702201;1673.907935063571;1755.1312100510202;1783.785945686513;1786.6694661487666;1790.0960015192375;63760;66099.33900660979;67818.66090669515;68110;68616.31383686149;9905.60377584903;9982.600695972225;10156.4921753912;10192.1336686381;10872.293300935573;14017.369218385196;14059.43762249519;14108.224047677271;14109;14123.78814317786;7533.8116547086765;7647;7663.961680191564;7829.41279404047;7849.960750196213;7467.626618669045;7479.962600187073;7597.810054748565;7601.581912994728;7614.505057171266;4292.527821939584;4395.648348132142;4436.3567282743825;4456.252283928019;4527.728336299832;1692.6530061337396;1783.3490775866715;1786.490850107713;1820.544863784054;1860.4001257566651;865.9997702653445;881.7619242804407;890.4746199742183;942.0014784328633;973.5083782689696;15695.764563531557;16576.502704918872;16930.746038809426;17102.315907363816;17313.2209050593;884.9336299777542;896.7444278380631;918.7657147427363;925.6066171876926;932.5803388475214;9429.2928030398;9474.810503789886;9632.422054676741;9706.70879873605;9822.361546499455;242551;246733;247054;392783;397529;51547.742261289204;80403.59798201089;81060;81318;83522;935.9017303183203;936.9906300936904;962.3456049886005;963.8409662405625;971.3831716859845;15345.156016419203;15613.453529126426;15725.921370393075;15866;16234.26945787466;29763.107106786832;30671.846640766653;34084.82957585196;35429.645703542636;35535.28929421449;46102.769486152356;46342.30486542637;46376;46381.53618463907;46425.30362044639;7179.210286868545;7330.523515971445;7342.70629174827;7432.591207483641;7530.510516816389;7213.026241457336;9935.850962235716;10065.496725163859;11360.488778005174;11813.40932953366;9772.169365604002;9933.950330248303;10101.44442055694;10120.038596333337;10345.37927724339;9087.227585655293;9716.3198576099;9898.455584942898;10341.586336546454;10445.268831181744;6616;8200.589970501333;10087.193024557871;10649.787004259717;10920.344779313267;7635.389168866366;7767.650455729618;7905.6837726492595;7921.445498815027;7954.164812694584;10006.249531285328;10008.349457285252;10048.145907597644;10204.591816327264;10501.78996420052 03:50:50 INFO - PROCESS | 8302 | |3;mootools.html;1310.1418570836095;1434.949776757813;1477.4090363854457;1613.322404590072;1749.8512626426761;7405.444591655627;7732.381409487241;7743.148253692097;7744.419168562366;7747.1090824555195;7576.659050342734;7738.110117336508;7753.806154846132;7757.922420775791;7764.18476060014;1925.5956249187686;2180.6401943679275;2213.147938043857;2246.674232236333;2247.5954328220914;2261.7738226177416;2286.2341115726167;2290.8167346612313;2291.713535808024;2291.942701432469;2157.6332023555956;2191.1783081344497;2220.622494175994;2223.6664500325;2228.142165266368;1743.6599863026652;2121.745390553128;2178.716766820319;2181.6291230490856;2189.419803752007;2157.1155826111376;2159.481724386136;2161.4164175672636;2187.048633844283;2189.058704756954;7592.468527203098;7699.653515591812;7715.074191097048;7718.343940764986;7721.922780772233;4439.356293337481;4597.42532183477;4599.011212589276;4601.723896566184;4602.838900638461;2854.0581608069288;2883.855807209652;2897.1163795042503;2912.606798082253;2967.762578993675;877.368294827723;881.0616693221698;884.4162852517308;902.3142411767038;902.8555431130987;10432.32189907661;10585.841212381743;10597.364158150536;10628.521716522775;10629.149668026617;4116.382542618571;4198.6221240088535;4344.3049112142535;4384.561543845653;4386.254336762758;8953.820923581492;8988.820223595492;9000.36997410175;9015.053419391;9024.503652299056;4742.241241401359;4748.358971538798;4759.619230461555;4768.046390721869;4783.760811959458;3710.4434334849448;4025.255327764373;4121.423000779893;4132.690048246393;4135.193637240769;3616.8914932552066;3671.834767435472;3713.4801127842125;3808.6953043756434;3825.6174382562076;1249.7188132670076;1254.1283807753707;1263.91784534005;1268.2010333490027;1270.5172034626783;713.4328209073799;828.7099515169642;837.7403005068448;847.0936098374804;852.1563651984491;5206.97396513015;5223;5406.783728650888;5487.670739755627;5506.421825708323;807.1928071928072;832.8750687396818;887.1970866365949;909.3225546967551;912.2109375390372;3619.5656521217097;3703.703703703697;3748.700103991674;3762.548494180716;3807.790571518593;8838.381313308135;8928.821423571491;9267.304952128483;9288.702510608771;9295.442273463614;9532.046795320413;9621.27840411972;9626.229901607994;9646.710598682052;9650.565724542412;7186.10173728284;7195.7481488148715;7294;7305.123385193704;7395.149557800922;4878.56092951636;4971.055499455092;4976.129177394014;4991.151504244214;5043.142665746758;8853.158949900007;8931.19619234272;8975.461472311683;8981.955090224506;9005.279577633904;8135.633896474791;8247.793805154679;8373.162683731578;8374.371922105745;8432.241098301183;5981.342052374148;6414.454771344488;6590.47276217911;6637.435817955527;6830.487713421613;7128.821779455555;7147.213806481387;7199.496035277481;7209.315115064271;7219.314165154302;6267.874642507033;6339.112524246517;6386.93613063882;6456.903146452713;6526.314736952551;6343.333949935375;6398.072279519351;6470.417662410406;6499.5775274607;6602.075709400784;5969.462748352669;6007.90988135187;6021.367756385516;6037.366076562073;6040.6677632730625;4370.519242883217;4567.703099298535;4630.83792067276;4695.366125573004;4736.336912832137;4329.588689074533;4333.068390296102;4339.088791353851;4417.469903611587;4438.911221775482 03:50:50 INFO - PROCESS | 8302 | |4;prototype.html;304.1044125051722;309.874500827165;314.54862272638763;315.38814699482987;316.24259897545363;4875.439324477687;4989.850304490862;4998.55013048826;5035.370578677665;5035.546800787933;4940.555350018498;4959.454460009396;4959.9008019839675;4964.304997300372;4966.652334336598;3701.7408781385316;3757.9248415031684;3934.252492026506;3944.3097457944887;3961.6038396160297;3898.2788184185874;3926.6858651307825;3939.606039396066;3941.817454763574;3954.7627142371407;3610.386234340155;3879.1465877506903;3900.609939006091;3911.2177564487074;3912.4913761211146;3783.3568293390053;3899.78551179685;3906.374980003214;3926.2343842950636;3935.232629637222;3481;3485.076454739496;3494.947575786365;3497.5977762557122;3502.4921386399083;4814.975925120387;4821.397325334333;4828.589569886564;4836.395450568679;4866;4169;4370.322599997005;4374.409454723604;4411.647068234533;4513.616342610882;5209.7134657593815;5210.400803907562;5211.739413029333;5221.2951251580935;5227.26818245446;3708.4066549351974;3709.610490898444;3714.3499887519847;3714.4056950888;3726.4782930389765;5173.275741396207;5423.511883930465;5505.311836020497;5510.228568000483;5535.086710692771;3791.1848952474797;3793.563740169916;3815.351390263662;3822.694184465236;3826.483424737625;3858.440526123696;3873.903152421212;3876.476675648808;3877.0695033192396;3877.1857909838686;4278.229918614679;4422.955770442319;4424.579664931826;4427.203103441347;4444.088961762831;5245.921311180336;5250.369955605275;5269.604779641542;5269.892043182681;5274.947250527445;1319.5183757928287;1347.4677502386503;1348.629126990066;1349.1230700045048;1354.780697372353;837.409626213518;862.8360611483798;888.1828717579842;907.4555266839975;925.3661242049218;4616.28447590624;4619.743081127797;4627.490975992638;4628.5371462853445;4643.535646435397;5370.62405631602;5376.1935709643085;5386.596005299618;5391.622586418992;5392.299001129906;4460.7323560586465;4570.908581828345;4574.08518296342;4601.953980460219;4627;2831.3912508810704;2831.957520637192;2838.8012839101066;2850.2874281429645;2867.842268675201;4999.875003124878;5009.824656137018;5012.122878496249;5040.168372218543;5049.318342023853;5265.973670131625;5417.756200970965;5445;5460.099083651233;5464.9453505465235;5021.774020169101;5038.1183292924325;5056.6713163644245;5057.468965758542;5076.517730815566;5311.203319502106;5336.424595521088;5337.893242135213;5346.893062138658;5347.973260133675;5082.2122571001555;5210.687358758487;5377.139657654757;5384.6769193848495;5409.459054094559;5167.58659307247;5179.274901513866;5183.896322073613;5187.144121220107;5197.454267301879;3791.8104094795704;3813.5995720450064;3818.427235914524;3822.7706337619834;3825.540935087807;5125.513076257749;5401.567874570103;5414.918776218438;5446.945530544803;5468.671879687232;5254.79139797841;5285.894282114259;5285.894282114413;5286.656367336111;5294.629375943647;5154.304168937146;5279.868003299948;5280.524752772269;5286.233496143114;5296.867578310573;5068.695878247317;5154.278401023935;5173.456787037307;5191.506806853343;5199.4020687621405;5029.27075574047;5100.872478188075;5270.73646317675;5288.788448462173;5290.836016076457;5142;5149.433562308068;5184.7926082957765;5187.610929180251;5194.584433245407 03:50:50 INFO - PROCESS | 8302 | |5;yui.html;650.5738741124562;699.9726184253107;746.8468963862408;782.3389236095497;784.2432053068791;11422.771544569103;12244.081693872973;12262.080343974216;12265.546890621878;12270.81593776094;10557.41934193619;10626.14990800736;10669.626563070295;10695.893041069587;10720.78558428833;635.1267007864187;779.0806847919453;804.2319584796535;814.9918500814975;816.3142959913671;809.0938149272794;809.0938149272823;810.2302812328282;811.0348685064783;811.1320886651285;834.6911642692182;837.9832403351929;839.1901814748766;843.1189407069596;844.3329769482102;661.4972620808196;821.137805304428;831.1439217605875;833.7165363776314;847.6990668312721;624.0265186309326;625.6777759453885;627.1721327847243;627.5105417774098;627.7834147219202;11773.764524709457;11831.408429578487;11834.763304733944;11849.763004739856;11867.287962722265;12058.758824823455;12387.566435174816;12443.191192572544;12517.74964500714;12850.357482125857;9133.132352426508;9462.90537094634;9642;9874.111329980264;9988.45063521506;3237.838108094586;3239.2063944333554;3248.2853772170083;3300.504924261356;3398.9660103398896;43771;43994.78002609999;44057.11885762267;44066.559334406564;44194.11611767779;9034.593443295067;9445.527723613792;9563.282753793494;9624.181944534794;9674.661386851427;16777;16912.408065717642;17012.234449449803;17017;17098.487045388658;6049.727762250709;6182;6216.347283535164;6252.812415627538;6338.873222535616;3664.1755604988666;3779.066874956488;3804.2771873343977;3852.768833869921;3894.8636797711943;2533.1134103063782;2645.404783923602;2648.0334677842447;2648.9205323840315;2653.9867300663373;492.8053418899515;497.0903247057948;499.93250911126535;502.30932467856695;504.14547342254525;534.7753943343805;592.8814237152586;599.3278752281087;599.9890730466843;602.1599868183858;7335.496223274216;7824.37405007598;7938.166492518202;8068.7175948841505;8247.876281855777;459.9310103484504;557.8912112138175;561.5180900420153;605.857623458487;627.4885967936209;3726.888193354204;3866.0721426857913;3900.726949113535;3946.1713040261866;3979.6816254699556;48914.75542622264;49575.752121239166;49707.751461243184;49814.750926245135;50400.49599504031;42953.78523107364;43305.35041974373;44399.778001109786;44648;44788.55211447909;39720;40169;40238.19523609511;40516;40866.9783255415;7885.211478852299;7981.680732770624;8135.67457301725;8183.754487365389;8281.503109813431;25817.612735809354;25967.350816229744;26251.73748262493;26381.736182637927;26718.465630687668;34820;34942.301153977285;36214.8189259052;36432.08919777027;36885.81557092305;10500.317479364123;10575.36547807134;10654.200934929757;10752.83870741955;10795.19036072282;11448.656540303471;11491.885081149081;12074.879251207376;12312.569060082855;12327.815082773586;10730.463476826284;10776.407297598395;10987.340759554452;11073.390963497084;11184.776304474028;10131.64539241123;10169.186465082628;10234.590616375262;10470.842937355794;10762.085222756154;10269.794604107727;10387.84418233712;10567.418791966516;10645.041946224877;10821.404822734825;9751.804963900824;9757.414555126716;9884.406935583887;9948.701538953843;10498.055175034284;9648.517574121406;9937.850932235877;9940.751481213027;9983.101520863158;10000 03:50:50 INFO - PROCESS | 8302 | __end_tp_report 03:50:50 INFO - PROCESS | 8302 | __start_cc_report 03:50:50 INFO - PROCESS | 8302 | _x_x_mozilla_cycle_collect,1148 03:50:50 INFO - PROCESS | 8302 | __end_cc_report 03:50:50 INFO - PROCESS | 8302 | __startTimestamp1461063050937__endTimestamp 03:50:50 INFO - PROCESS | 8302 | 03:50:50 INFO - PROCESS | 8302 | ------- Summary: start ------- 03:50:50 INFO - PROCESS | 8302 | Number of tests: 6 03:50:50 INFO - PROCESS | 8302 | 03:50:50 INFO - PROCESS | 8302 | [#0] dojo.html Cycles:165 Average:4561.42 Median:4686.67 stddev:460.62 (9.8%) stddev-sans-first:435.04 03:50:50 INFO - PROCESS | 8302 | Values: 2581.0 2656.8 2670.4 2681.3 2700.3 4497.3 4557.5 4568.0 4573.9 4654.0 4625.1 4633.1 4671.6 4701.5 4701.8 4203.6 4223.3 4264.4 4289.5 4414.4 4332.6 4357.4 4373.0 4376.1 4404.6 4165.8 4165.9 4207.6 4245.6 4251.3 4199.9 4203.5 4206.7 4213.8 4266.8 4218.5 4224.8 4236.6 4259.5 4272.8 4416.2 4499.1 4561.4 4608.7 4622.9 4975.8 4980.2 5004.6 5024.1 5045.2 4821.4 4958.1 5008.5 5012.4 5026.5 4605.4 4693.7 4703.0 4707.1 4707.9 5003.2 5005.6 5005.7 5011.1 5026.6 4823.5 4823.8 4824.3 4827.7 4876.0 4690.2 4915.8 4964.3 4998.0 5014.5 4868.2 4879.9 4882.3 4885.1 4937.1 4707.8 4855.4 4861.1 4864.1 4909.9 4116.5 4165.9 4231.4 4245.0 4246.8 3649.2 3660.8 3662.3 3690.1 3705.0 4264.4 4268.9 4270.0 4271.8 4309.0 4784.6 4945.2 4997.9 5032.2 5044.5 4259.4 4275.8 4295.4 4295.8 4335.9 4298.6 4459.6 4460.6 4467.5 4495.2 4644.0 4677.6 4677.8 4716.3 4719.7 4929.9 4946.6 4947.5 4947.8 4978.9 4555.4 4671.3 4675.0 4679.0 4726.1 4846.2 4876.0 4881.6 4889.5 4928.6 4887.5 4905.9 4923.3 4924.5 4968.6 4653.0 4759.1 4804.9 4820.6 4846.9 4720.6 4735.3 4741.8 4786.4 4795.4 4676.1 4677.3 4686.7 4705.8 4712.5 4666.2 4700.2 4758.3 4785.8 4862.7 4662.4 4680.8 4713.1 4715.4 4741.2 03:50:50 INFO - PROCESS | 8302 | 03:50:50 INFO - PROCESS | 8302 | [#1] ext.html Cycles:180 Average:44237.87 Median:34843.33 stddev:76787.46 (220.4%) stddev-sans-first:76932.82 03:50:50 INFO - PROCESS | 8302 | Values: 554.1 594.3 604.5 612.6 629.4 33799.8 34213.3 35064.5 35448.0 35461.3 36795.1 37534.4 37629.2 37657.8 37672.2 7149.6 7510.8 7760.2 7772.7 9494.1 9534.6 9723.9 9727.6 9728.9 9731.0 9680.0 9790.7 9801.9 9805.5 9819.0 9672.6 9769.5 9778.9 9784.1 9786.4 9663.3 9764.5 9768.4 9770.5 10052.0 38308.2 38749.6 38764.4 38806.6 38824.6 2801.2 2806.5 2823.7 2872.0 3167.3 28973.4 29156.9 29213.1 29283.1 29382.9 3333.9 3375.7 3413.6 3442.2 3482.2 214235.6 215507.0 215639.0 216105.0 216461.0 54875.5 54948.2 55084.0 55360.0 55404.4 52319.0 52349.7 52353.5 52401.5 52434.0 14154.0 14804.0 14838.0 14838.3 14845.2 10084.4 11429.5 11712.4 11805.0 12073.8 18163.7 18408.4 18417.0 18422.3 18444.0 6873.8 7180.2 7212.7 7302.9 7346.0 790.4 901.2 952.6 1010.8 1030.0 28305.7 28430.7 29559.7 30626.0 31273.0 951.1 994.9 1013.5 1015.3 1099.7 14280.1 14619.3 14717.6 14932.5 15020.1 328489.0 332297.0 334818.0 335071.0 335627.0 48558.5 49429.5 49437.3 49565.0 49576.8 1146.5 1188.6 1274.3 1285.0 1298.3 24567.4 26856.9 27854.7 28283.9 28627.0 40470.8 41203.4 41254.6 41257.0 41450.0 241544.0 247201.0 247251.0 247854.0 500110.0 25627.4 26166.2 26358.7 26398.7 26851.2 40147.4 40423.3 41163.8 41335.4 41472.2 34820.0 34973.7 35097.5 35652.6 35962.6 34652.0 34866.7 34989.0 35157.5 35216.5 34518.5 34778.1 34873.3 35423.8 35460.3 29972.0 31285.5 31414.4 31508.1 31668.0 24582.8 24803.8 24860.0 25008.6 25029.5 03:50:50 INFO - PROCESS | 8302 | 03:50:50 INFO - PROCESS | 8302 | [#2] jquery.html Cycles:180 Average:21328.16 Median:46378.77 stddev:52443.35 (113.1%) stddev-sans-first:52566.86 03:50:50 INFO - PROCESS | 8302 | Values: 372.8 373.8 377.6 378.5 389.2 16757.7 17278.2 17661.6 17702.4 17703.3 12177.0 15608.6 16207.2 16222.9 16239.8 4509.9 4640.1 4712.9 4729.0 4740.4 3427.7 4589.6 5087.9 5397.8 5417.4 5385.5 5385.5 5394.2 5415.3 5415.5 5112.7 5382.3 5430.7 5434.5 5439.3 3327.6 5047.3 5286.0 5372.5 5389.2 12099.3 12212.5 12270.6 13709.7 20343.6 1838.2 1887.0 1889.0 1913.5 2286.2 8701.8 9065.2 9403.0 9514.7 9596.3 1673.9 1755.1 1783.8 1786.7 1790.1 63760.0 66099.3 67818.7 68110.0 68616.3 9905.6 9982.6 10156.5 10192.1 10872.3 14017.4 14059.4 14108.2 14109.0 14123.8 7533.8 7647.0 7664.0 7829.4 7850.0 7467.6 7480.0 7597.8 7601.6 7614.5 4292.5 4395.6 4436.4 4456.3 4527.7 1692.7 1783.3 1786.5 1820.5 1860.4 866.0 881.8 890.5 942.0 973.5 15695.8 16576.5 16930.7 17102.3 17313.2 884.9 896.7 918.8 925.6 932.6 9429.3 9474.8 9632.4 9706.7 9822.4 242551.0 246733.0 247054.0 392783.0 397529.0 51547.7 80403.6 81060.0 81318.0 83522.0 935.9 937.0 962.3 963.8 971.4 15345.2 15613.5 15725.9 15866.0 16234.3 29763.1 30671.8 34084.8 35429.6 35535.3 46102.8 46342.3 46376.0 46381.5 46425.3 7179.2 7330.5 7342.7 7432.6 7530.5 7213.0 9935.9 10065.5 11360.5 11813.4 9772.2 9934.0 10101.4 10120.0 10345.4 9087.2 9716.3 9898.5 10341.6 10445.3 6616.0 8200.6 10087.2 10649.8 10920.3 7635.4 7767.7 7905.7 7921.4 7954.2 10006.2 10008.3 10048.1 10204.6 10501.8 03:50:50 INFO - PROCESS | 8302 | 03:50:50 INFO - PROCESS | 8302 | [#3] mootools.html Cycles:180 Average:5056.72 Median:5214.99 stddev:2789.48 (53.5%) stddev-sans-first:2783.10 03:50:50 INFO - PROCESS | 8302 | Values: 1310.1 1434.9 1477.4 1613.3 1749.9 7405.4 7732.4 7743.1 7744.4 7747.1 7576.7 7738.1 7753.8 7757.9 7764.2 1925.6 2180.6 2213.1 2246.7 2247.6 2261.8 2286.2 2290.8 2291.7 2291.9 2157.6 2191.2 2220.6 2223.7 2228.1 1743.7 2121.7 2178.7 2181.6 2189.4 2157.1 2159.5 2161.4 2187.0 2189.1 7592.5 7699.7 7715.1 7718.3 7721.9 4439.4 4597.4 4599.0 4601.7 4602.8 2854.1 2883.9 2897.1 2912.6 2967.8 877.4 881.1 884.4 902.3 902.9 10432.3 10585.8 10597.4 10628.5 10629.1 4116.4 4198.6 4344.3 4384.6 4386.3 8953.8 8988.8 9000.4 9015.1 9024.5 4742.2 4748.4 4759.6 4768.0 4783.8 3710.4 4025.3 4121.4 4132.7 4135.2 3616.9 3671.8 3713.5 3808.7 3825.6 1249.7 1254.1 1263.9 1268.2 1270.5 713.4 828.7 837.7 847.1 852.2 5207.0 5223.0 5406.8 5487.7 5506.4 807.2 832.9 887.2 909.3 912.2 3619.6 3703.7 3748.7 3762.5 3807.8 8838.4 8928.8 9267.3 9288.7 9295.4 9532.0 9621.3 9626.2 9646.7 9650.6 7186.1 7195.7 7294.0 7305.1 7395.1 4878.6 4971.1 4976.1 4991.2 5043.1 8853.2 8931.2 8975.5 8982.0 9005.3 8135.6 8247.8 8373.2 8374.4 8432.2 5981.3 6414.5 6590.5 6637.4 6830.5 7128.8 7147.2 7199.5 7209.3 7219.3 6267.9 6339.1 6386.9 6456.9 6526.3 6343.3 6398.1 6470.4 6499.6 6602.1 5969.5 6007.9 6021.4 6037.4 6040.7 4370.5 4567.7 4630.8 4695.4 4736.3 4329.6 4333.1 4339.1 4417.5 4438.9 03:50:50 INFO - PROCESS | 8302 | 03:50:50 INFO - PROCESS | 8302 | [#4] prototype.html Cycles:180 Average:4343.81 Median:4978.25 stddev:1261.07 (25.3%) stddev-sans-first:1227.62 03:50:50 INFO - PROCESS | 8302 | Values: 304.1 309.9 314.5 315.4 316.2 4875.4 4989.9 4998.6 5035.4 5035.5 4940.6 4959.5 4959.9 4964.3 4966.7 3701.7 3757.9 3934.3 3944.3 3961.6 3898.3 3926.7 3939.6 3941.8 3954.8 3610.4 3879.1 3900.6 3911.2 3912.5 3783.4 3899.8 3906.4 3926.2 3935.2 3481.0 3485.1 3494.9 3497.6 3502.5 4815.0 4821.4 4828.6 4836.4 4866.0 4169.0 4370.3 4374.4 4411.6 4513.6 5209.7 5210.4 5211.7 5221.3 5227.3 3708.4 3709.6 3714.3 3714.4 3726.5 5173.3 5423.5 5505.3 5510.2 5535.1 3791.2 3793.6 3815.4 3822.7 3826.5 3858.4 3873.9 3876.5 3877.1 3877.2 4278.2 4423.0 4424.6 4427.2 4444.1 5245.9 5250.4 5269.6 5269.9 5274.9 1319.5 1347.5 1348.6 1349.1 1354.8 837.4 862.8 888.2 907.5 925.4 4616.3 4619.7 4627.5 4628.5 4643.5 5370.6 5376.2 5386.6 5391.6 5392.3 4460.7 4570.9 4574.1 4602.0 4627.0 2831.4 2832.0 2838.8 2850.3 2867.8 4999.9 5009.8 5012.1 5040.2 5049.3 5266.0 5417.8 5445.0 5460.1 5464.9 5021.8 5038.1 5056.7 5057.5 5076.5 5311.2 5336.4 5337.9 5346.9 5348.0 5082.2 5210.7 5377.1 5384.7 5409.5 5167.6 5179.3 5183.9 5187.1 5197.5 3791.8 3813.6 3818.4 3822.8 3825.5 5125.5 5401.6 5414.9 5446.9 5468.7 5254.8 5285.9 5285.9 5286.7 5294.6 5154.3 5279.9 5280.5 5286.2 5296.9 5068.7 5154.3 5173.5 5191.5 5199.4 5029.3 5100.9 5270.7 5288.8 5290.8 5142.0 5149.4 5184.8 5187.6 5194.6 03:50:50 INFO - PROCESS | 8302 | 03:50:50 INFO - PROCESS | 8302 | [#5] yui.html Cycles:180 Average:12208.12 Median:44025.95 stddev:13590.97 (30.9%) stddev-sans-first:13601.38 03:50:50 INFO - PROCESS | 8302 | Values: 650.6 700.0 746.8 782.3 784.2 11422.8 12244.1 12262.1 12265.5 12270.8 10557.4 10626.1 10669.6 10695.9 10720.8 635.1 779.1 804.2 815.0 816.3 809.1 809.1 810.2 811.0 811.1 834.7 838.0 839.2 843.1 844.3 661.5 821.1 831.1 833.7 847.7 624.0 625.7 627.2 627.5 627.8 11773.8 11831.4 11834.8 11849.8 11867.3 12058.8 12387.6 12443.2 12517.7 12850.4 9133.1 9462.9 9642.0 9874.1 9988.5 3237.8 3239.2 3248.3 3300.5 3399.0 43771.0 43994.8 44057.1 44066.6 44194.1 9034.6 9445.5 9563.3 9624.2 9674.7 16777.0 16912.4 17012.2 17017.0 17098.5 6049.7 6182.0 6216.3 6252.8 6338.9 3664.2 3779.1 3804.3 3852.8 3894.9 2533.1 2645.4 2648.0 2648.9 2654.0 492.8 497.1 499.9 502.3 504.1 534.8 592.9 599.3 600.0 602.2 7335.5 7824.4 7938.2 8068.7 8247.9 459.9 557.9 561.5 605.9 627.5 3726.9 3866.1 3900.7 3946.2 3979.7 48914.8 49575.8 49707.8 49814.8 50400.5 42953.8 43305.4 44399.8 44648.0 44788.6 39720.0 40169.0 40238.2 40516.0 40867.0 7885.2 7981.7 8135.7 8183.8 8281.5 25817.6 25967.4 26251.7 26381.7 26718.5 34820.0 34942.3 36214.8 36432.1 36885.8 10500.3 10575.4 10654.2 10752.8 10795.2 11448.7 11491.9 12074.9 12312.6 12327.8 10730.5 10776.4 10987.3 11073.4 11184.8 10131.6 10169.2 10234.6 10470.8 10762.1 10269.8 10387.8 10567.4 10645.0 10821.4 9751.8 9757.4 9884.4 9948.7 10498.1 9648.5 9937.9 9940.8 9983.1 10000.0 03:50:50 INFO - PROCESS | 8302 | -------- Summary: end -------- 03:50:50 INFO - PROCESS | 8302 | 03:50:51 INFO - TEST-INFO | 8302: exit 0 03:50:51 INFO - TEST-OK | dromaeo_css | took 1117974ms 03:50:51 INFO - TEST-START | kraken 03:50:51 INFO - operating with platform_type : linux_ 03:50:51 INFO - Initialising browser for kraken test... 03:50:51 INFO - TEST-INFO | started process 8477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu7kKIf/profile http://localhost:44423/getInfo.html) 03:50:55 INFO - PROCESS | 8477 | __metrics Screen width/height:1600/1200 03:50:55 INFO - PROCESS | 8477 | colorDepth:24 03:50:55 INFO - PROCESS | 8477 | Browser inner width/height: 1024/697 03:50:55 INFO - PROCESS | 8477 | __metrics 03:50:56 ERROR - PROCESS | 8477 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:50:57 INFO - TEST-INFO | 8477: exit 0 03:50:57 INFO - Browser initialized. 03:50:57 INFO - Running cycle 1/1 for kraken test... 03:50:57 INFO - TEST-INFO | started process 8558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu7kKIf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:09 INFO - PROCESS | 8558 | RSS: Main: 154710016 03:51:09 INFO - PROCESS | 8558 | 03:51:12 INFO - PROCESS | 8558 | Cycle 1(1): loaded http://localhost:44423/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44423/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:13 INFO - PROCESS | 8558 | RSS: Main: 209817600 03:51:13 INFO - PROCESS | 8558 | 03:51:16 INFO - PROCESS | 8558 | Cycle 1(1): loaded http://localhost:44423/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44423/tests/kraken/driver.html?testName=audio-dft) 03:51:16 INFO - PROCESS | 8558 | RSS: Main: 195268608 03:51:16 INFO - PROCESS | 8558 | 03:51:20 INFO - PROCESS | 8558 | Cycle 1(1): loaded http://localhost:44423/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44423/tests/kraken/driver.html?testName=audio-fft) 03:51:20 INFO - PROCESS | 8558 | RSS: Main: 264519680 03:51:20 INFO - PROCESS | 8558 | 03:51:22 INFO - PROCESS | 8558 | Cycle 1(1): loaded http://localhost:44423/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44423/tests/kraken/driver.html?testName=audio-oscillator) 03:51:23 INFO - PROCESS | 8558 | RSS: Main: 174288896 03:51:23 INFO - PROCESS | 8558 | 03:51:25 INFO - PROCESS | 8558 | Cycle 1(1): loaded http://localhost:44423/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44423/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:26 INFO - PROCESS | 8558 | RSS: Main: 178634752 03:51:26 INFO - PROCESS | 8558 | 03:51:29 INFO - PROCESS | 8558 | Cycle 1(1): loaded http://localhost:44423/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44423/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:29 INFO - PROCESS | 8558 | RSS: Main: 214388736 03:51:29 INFO - PROCESS | 8558 | 03:51:33 INFO - PROCESS | 8558 | Cycle 1(1): loaded http://localhost:44423/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44423/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:33 INFO - PROCESS | 8558 | RSS: Main: 215334912 03:51:33 INFO - PROCESS | 8558 | 03:51:36 INFO - PROCESS | 8558 | Cycle 1(1): loaded http://localhost:44423/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44423/tests/kraken/driver.html?testName=json-parse-financial) 03:51:37 INFO - PROCESS | 8558 | RSS: Main: 215560192 03:51:37 INFO - PROCESS | 8558 | 03:51:39 INFO - PROCESS | 8558 | Cycle 1(1): loaded http://localhost:44423/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44423/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:39 INFO - PROCESS | 8558 | RSS: Main: 201166848 03:51:39 INFO - PROCESS | 8558 | 03:51:41 INFO - PROCESS | 8558 | Cycle 1(1): loaded http://localhost:44423/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44423/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:42 INFO - PROCESS | 8558 | RSS: Main: 204918784 03:51:42 INFO - PROCESS | 8558 | 03:51:44 INFO - PROCESS | 8558 | Cycle 1(1): loaded http://localhost:44423/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44423/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:45 INFO - PROCESS | 8558 | RSS: Main: 218222592 03:51:45 INFO - PROCESS | 8558 | 03:51:47 INFO - PROCESS | 8558 | Cycle 1(1): loaded http://localhost:44423/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:48 INFO - PROCESS | 8558 | RSS: Main: 223879168 03:51:48 INFO - PROCESS | 8558 | 03:51:51 INFO - PROCESS | 8558 | Cycle 1(1): loaded http://localhost:44423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:51 INFO - PROCESS | 8558 | RSS: Main: 219193344 03:51:51 INFO - PROCESS | 8558 | 03:51:53 INFO - PROCESS | 8558 | Cycle 1(1): loaded http://localhost:44423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44423/tests/kraken/driver.html?testName=ai-astar) 03:51:53 INFO - PROCESS | 8558 | RSS: Main: 283025408 03:51:53 INFO - PROCESS | 8558 | 03:51:54 INFO - PROCESS | 8558 | __start_tp_report 03:51:54 INFO - PROCESS | 8558 | _x_x_mozilla_page_load 03:51:54 INFO - PROCESS | 8558 | _x_x_mozilla_page_load_details 03:51:54 INFO - PROCESS | 8558 | |i|pagename|runs| 03:51:54 INFO - PROCESS | 8558 | |0;ai-astar;111;114;110;113;114;113;104;113;113;113 03:51:54 INFO - PROCESS | 8558 | |1;audio-beat-detection;167;139;156;195;140;159;172;134;193;139 03:51:54 INFO - PROCESS | 8558 | |2;audio-dft;161;161;161;159;161;163;162;161;161;160 03:51:54 INFO - PROCESS | 8558 | |3;audio-fft;75;74;104;110;77;77;74;115;105;73 03:51:54 INFO - PROCESS | 8558 | |4;audio-oscillator;95;95;141;93;94;94;155;93;95;143 03:51:54 INFO - PROCESS | 8558 | |5;imaging-gaussian-blur;118;117;118;116;117;118;117;118;117;116 03:51:54 INFO - PROCESS | 8558 | |6;imaging-darkroom;146;146;146;146;145;146;146;145;146;146 03:51:54 INFO - PROCESS | 8558 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 03:51:54 INFO - PROCESS | 8558 | |8;json-parse-financial;64;65;64;66;64;65;66;83;64;64 03:51:54 INFO - PROCESS | 8558 | |9;json-stringify-tinderbox;66;65;64;65;66;65;65;65;66;66 03:51:54 INFO - PROCESS | 8558 | |10;stanford-crypto-aes;79;79;77;78;80;78;80;80;80;80 03:51:54 INFO - PROCESS | 8558 | |11;stanford-crypto-ccm;133;142;143;131;129;133;134;129;165;135 03:51:54 INFO - PROCESS | 8558 | |12;stanford-crypto-pbkdf2;174;175;170;170;180;176;172;178;177;182 03:51:54 INFO - PROCESS | 8558 | |13;stanford-crypto-sha256-iterative;72;71;72;75;72;72;71;70;72;71 03:51:54 INFO - PROCESS | 8558 | __end_tp_report 03:51:54 INFO - PROCESS | 8558 | __start_cc_report 03:51:54 INFO - PROCESS | 8558 | _x_x_mozilla_cycle_collect,1886 03:51:54 INFO - PROCESS | 8558 | __end_cc_report 03:51:54 INFO - PROCESS | 8558 | __startTimestamp1461063114001__endTimestamp 03:51:54 INFO - PROCESS | 8558 | 03:51:54 INFO - PROCESS | 8558 | ------- Summary: start ------- 03:51:54 INFO - PROCESS | 8558 | Number of tests: 14 03:51:54 INFO - PROCESS | 8558 | 03:51:54 INFO - PROCESS | 8558 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:3.01 (2.7%) stddev-sans-first:3.18 03:51:54 INFO - PROCESS | 8558 | Values: 111.0 114.0 110.0 113.0 114.0 113.0 104.0 113.0 113.0 113.0 03:51:54 INFO - PROCESS | 8558 | 03:51:54 INFO - PROCESS | 8558 | [#1] audio-beat-detection Cycles:10 Average:159.40 Median:163.00 stddev:22.31 (13.7%) stddev-sans-first:23.49 03:51:54 INFO - PROCESS | 8558 | Values: 167.0 139.0 156.0 195.0 140.0 159.0 172.0 134.0 193.0 139.0 03:51:54 INFO - PROCESS | 8558 | 03:51:54 INFO - PROCESS | 8558 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 03:51:54 INFO - PROCESS | 8558 | Values: 161.0 161.0 161.0 159.0 161.0 163.0 162.0 161.0 161.0 160.0 03:51:54 INFO - PROCESS | 8558 | 03:51:54 INFO - PROCESS | 8558 | [#3] audio-fft Cycles:10 Average:88.40 Median:74.00 stddev:17.59 (23.8%) stddev-sans-first:17.98 03:51:54 INFO - PROCESS | 8558 | Values: 75.0 74.0 104.0 110.0 77.0 77.0 74.0 115.0 105.0 73.0 03:51:54 INFO - PROCESS | 8558 | 03:51:54 INFO - PROCESS | 8558 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:94.00 stddev:25.47 (27.1%) stddev-sans-first:26.45 03:51:54 INFO - PROCESS | 8558 | Values: 95.0 95.0 141.0 93.0 94.0 94.0 155.0 93.0 95.0 143.0 03:51:54 INFO - PROCESS | 8558 | 03:51:54 INFO - PROCESS | 8558 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.50 stddev:0.79 (0.7%) stddev-sans-first:0.78 03:51:54 INFO - PROCESS | 8558 | Values: 118.0 117.0 118.0 116.0 117.0 118.0 117.0 118.0 117.0 116.0 03:51:54 INFO - PROCESS | 8558 | 03:51:54 INFO - PROCESS | 8558 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 03:51:54 INFO - PROCESS | 8558 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 03:51:54 INFO - PROCESS | 8558 | 03:51:54 INFO - PROCESS | 8558 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 03:51:54 INFO - PROCESS | 8558 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 03:51:54 INFO - PROCESS | 8558 | 03:51:54 INFO - PROCESS | 8558 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:65.00 stddev:5.85 (9.0%) stddev-sans-first:6.14 03:51:54 INFO - PROCESS | 8558 | Values: 64.0 65.0 64.0 66.0 64.0 65.0 66.0 83.0 64.0 64.0 03:51:54 INFO - PROCESS | 8558 | 03:51:54 INFO - PROCESS | 8558 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 03:51:54 INFO - PROCESS | 8558 | Values: 66.0 65.0 64.0 65.0 66.0 65.0 65.0 65.0 66.0 66.0 03:51:54 INFO - PROCESS | 8558 | 03:51:54 INFO - PROCESS | 8558 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:80.00 stddev:1.10 (1.4%) stddev-sans-first:1.17 03:51:54 INFO - PROCESS | 8558 | Values: 79.0 79.0 77.0 78.0 80.0 78.0 80.0 80.0 80.0 80.0 03:51:54 INFO - PROCESS | 8558 | 03:51:54 INFO - PROCESS | 8558 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:134.50 stddev:10.81 (8.0%) stddev-sans-first:11.35 03:51:54 INFO - PROCESS | 8558 | Values: 133.0 142.0 143.0 131.0 129.0 133.0 134.0 129.0 165.0 135.0 03:51:54 INFO - PROCESS | 8558 | 03:51:54 INFO - PROCESS | 8558 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.40 Median:176.50 stddev:4.03 (2.3%) stddev-sans-first:4.25 03:51:54 INFO - PROCESS | 8558 | Values: 174.0 175.0 170.0 170.0 180.0 176.0 172.0 178.0 177.0 182.0 03:51:54 INFO - PROCESS | 8558 | 03:51:54 INFO - PROCESS | 8558 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.00 stddev:1.32 (1.8%) stddev-sans-first:1.39 03:51:54 INFO - PROCESS | 8558 | Values: 72.0 71.0 72.0 75.0 72.0 72.0 71.0 70.0 72.0 71.0 03:51:54 INFO - PROCESS | 8558 | -------- Summary: end -------- 03:51:54 INFO - PROCESS | 8558 | 03:51:54 INFO - TEST-INFO | 8558: exit 0 03:51:55 INFO - TEST-OK | kraken | took 63321ms 03:51:55 INFO - SUITE-END | took 1181s 03:51:55 INFO - Completed test suite (00:19:41) 03:51:55 INFO - javascript benchmark 03:51:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2581.0, 2656.78745700344, 2670.3858112634107, 2681.262652770488, 2700.2979225401396, 4497.3029180477, 4557.498675145735, 4568.0, 4573.931391029133, 4654.04592058628, 4625.144348295567, 4633.119707255619, 4671.626269898408, 4701.529847015297, 4701.788419521121, 4203.579642035787, 4223.32426811711, 4264.381664658623, 4289.506706728719, 4414.359917811916, 4332.610065094141, 4357.38996540483, 4373.037931655047, 4376.059147283333, 4404.581564751344, 4165.812538435777, 4165.937510937339, 4207.579242075799, 4245.57544245573, 4251.319788833803, 4199.9370009449885, 4203.453551038376, 4206.705530612859, 4213.831446742127, 4266.786660666954, 4218.493780746299, 4224.809883555216, 4236.639885609727, 4259.488861336628, 4272.829086836523, 4416.183006143874, 4499.10017996402, 4561.361409402686, 4608.677392582521, 4622.884427889296, 4975.776090075955, 4980.203167493184, 5004.649674522785, 5024.145895197788, 5045.243213517965, 4821.397325334333, 4958.132326842824, 5008.499150084962, 5012.448630650625, 5026.497350264981, 4605.4473463184295, 4693.694909830884, 4703.0, 4707.105649926503, 4707.882302942454, 5003.224500202475, 5005.649604527648, 5005.674631148963, 5011.072951503984, 5026.597872170218, 4823.541763532458, 4823.807047718122, 4824.324594556765, 4827.686200396963, 4875.95124048762, 4690.226112691368, 4915.8033678652455, 4964.255361695702, 4998.0, 5014.548690617862, 4868.196747536687, 4879.926801097987, 4882.292067650171, 4885.09625719236, 4937.086638971802, 4707.835225767081, 4855.44162421319, 4861.076395484846, 4864.124457597666, 4909.926351104737, 4116.5060192777055, 4165.854195103157, 4231.449911511545, 4244.957550424518, 4246.787660616957, 3649.197176621139, 3660.816959152032, 3662.285854258447, 3690.095926498025, 3704.9629503705155, 4264.445622069111, 4268.914621707549, 4269.978650106729, 4271.786410679453, 4308.978455107705, 4784.64115191362, 4945.208766597327, 4997.925031124536, 5032.245163225545, 5044.520770526794, 4259.382389553497, 4275.786210689453, 4295.4415925929425, 4295.8496452624, 4335.913281734348, 4298.613124818781, 4459.620932220732, 4460.553944605514, 4467.530909254547, 4495.213337665896, 4644.047970166175, 4677.602403795716, 4677.836275730333, 4716.29255611661, 4719.7404142772475, 4929.852104436873, 4946.579540738933, 4947.48051454592, 4947.752612369439, 4978.925316120333, 4555.3850230218495, 4671.299305104261, 4675.0, 4678.976605116953, 4726.054789042274, 4846.176150054429, 4875.975620121877, 4881.58506526935, 4889.535494128052, 4928.630352723489, 4887.486813884491, 4905.9018819624125, 4923.261510773269, 4924.458309585871, 4968.602511799119, 4652.976735116303, 4759.143354196278, 4804.855854324376, 4820.638452116035, 4846.854594362175, 4720.575148236675, 4735.33705281254, 4741.786619602057, 4786.44955830084, 4795.448523419851, 4676.134915040729, 4677.345171676036, 4686.671932964659, 4705.835295764632, 4712.50518695532, 4666.183417901786, 4700.2244629635725, 4758.286257061469, 4785.760711964318, 4862.708237505761, 4662.393888794435, 4680.7893644786745, 4713.057388522378, 4715.3869996900185, 4741.241401375763], "value": 4533.48726838211, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.0525701051203, 594.3491876395349, 604.4892066204058, 612.647727556655, 629.4492319220683, 33799.83100084499, 34213.31573368531, 35064.47403288953, 35448.0, 35461.2907741845, 36795.08012299694, 37534.4369834452, 37629.24741505168, 37657.811710941474, 37672.24655506888, 7149.642517874112, 7510.849783004351, 7760.185180556045, 7772.65023073963, 9494.098060684224, 9534.618615255382, 9723.902760972405, 9727.562259698296, 9728.854067188999, 9731.0, 9680.0, 9790.706278811647, 9801.941592265634, 9805.509724513746, 9819.0, 9672.56473458696, 9769.51152442375, 9778.90221097787, 9784.070513301225, 9786.41281523111, 9663.27525435595, 9764.462954537568, 9768.413895166314, 9770.51147442625, 10052.045055719695, 38308.233835323415, 38749.61250387516, 38764.41853372202, 38806.611933880864, 38824.611753882666, 2801.1596521043607, 2806.5369214079856, 2823.745862872351, 2871.9712802871913, 3167.303193297471, 28973.42053158946, 29156.854215729, 29213.123606291632, 29283.121506354844, 29382.85308573465, 3333.93332133356, 3375.6961873431264, 3413.641567635387, 3442.1738782691973, 3482.164280572644, 214235.64410889853, 215507.0, 215639.0, 216104.99999999843, 216461.0, 54875.451245487835, 54948.17577736337, 55084.0, 55360.0, 55404.44595554074, 52319.0, 52349.7382513085, 52353.476465235624, 52401.47598523966, 52434.0, 14154.0, 14804.0, 14838.035527690665, 14838.33227504765, 14845.183514906785, 10084.394936303845, 11429.485673144729, 11712.355820429959, 11805.0, 12073.758524829454, 18163.72754408685, 18408.35570755017, 18417.0, 18422.263109475472, 18444.0, 6873.759418420332, 7180.1742799578715, 7212.71149154028, 7302.890456643155, 7346.0, 790.426940468156, 901.2204443156622, 952.64752041745, 1010.8231059564694, 1029.9742506437249, 28305.71694283072, 28430.71569284281, 29559.704402956126, 30626.0, 31273.0, 951.1487218939011, 994.9403035817874, 1013.4527355228241, 1015.3248090020202, 1099.741560733227, 14280.14319140834, 14619.26903654813, 14717.632059198391, 14932.477363292233, 15020.09879407239, 328489.0, 332297.0, 334818.0, 335071.0, 335627.0, 48558.51441485611, 49429.50570494321, 49437.25844112341, 49565.0, 49576.752116239186, 1146.5356530605118, 1188.5721140389453, 1274.3437129878305, 1284.9871501284867, 1298.2729671383865, 24567.38581535476, 26856.865715671298, 27854.721452786023, 28283.858580707787, 28627.0, 40470.79764601158, 41203.38194927019, 41254.587454125074, 41257.0, 41450.0, 241544.0, 247201.0, 247251.0, 247854.0, 500110.0, 25627.35931601725, 26166.215013549623, 26358.73641263563, 26398.736012639627, 26851.194464166107, 40147.39778903377, 40423.3237199007, 41163.794181028905, 41335.37996929988, 41472.170556589306, 34820.0, 34973.65026349704, 35097.47353789644, 35652.61300176479, 35962.64037359593, 34652.0, 34866.65133348735, 34989.0, 35157.47263790994, 35216.47175292424, 34518.48222276618, 34778.13054673552, 34873.30253394867, 35423.82288088543, 35460.29079418346, 29972.0, 31285.530717038808, 31414.371712566077, 31508.054758357284, 31668.04995850128, 24582.75417245876, 24803.791203847395, 24860.0, 25008.624870627318, 25029.49941001206], "value": 17717.918949095954, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.821045897969, 373.8074891430913, 377.5582568394978, 378.5155001597956, 389.18465814119446, 16757.664846703057, 17278.2224799884, 17661.55846103848, 17702.380416685417, 17703.29186832525, 12177.025837932966, 15608.60978475536, 16207.189640517956, 16222.918885405556, 16239.83760162398, 4509.90980180397, 4640.141573808839, 4712.929306060412, 4729.0, 4740.407449068866, 3427.6915077643007, 4589.632829373659, 5087.923681144785, 5397.811076612319, 5417.431169727181, 5385.515303622673, 5385.542228910528, 5394.1908713692865, 5415.268938693265, 5415.539679127279, 5112.744362781865, 5382.300300960869, 5430.70131142787, 5434.510894019557, 5439.347278326626, 3327.600687917441, 5047.293378926953, 5286.0, 5372.489613486712, 5389.191621256804, 12099.274043557414, 12212.511499540007, 12270.631881043493, 13709.657258568515, 20343.5931281375, 1838.218757028271, 1886.9905650471796, 1888.9716654250196, 1913.4546654203484, 2286.1998300594823, 8701.825963480758, 9065.184133427958, 9403.012683668254, 9514.666986655433, 9596.32825702201, 1673.907935063571, 1755.1312100510202, 1783.785945686513, 1786.6694661487666, 1790.0960015192375, 63760.0, 66099.33900660979, 67818.66090669515, 68110.0, 68616.31383686149, 9905.60377584903, 9982.600695972225, 10156.4921753912, 10192.1336686381, 10872.293300935573, 14017.369218385196, 14059.43762249519, 14108.224047677271, 14109.0, 14123.78814317786, 7533.8116547086765, 7647.0, 7663.961680191564, 7829.41279404047, 7849.960750196213, 7467.626618669045, 7479.962600187073, 7597.810054748565, 7601.581912994728, 7614.505057171266, 4292.527821939584, 4395.648348132142, 4436.3567282743825, 4456.252283928019, 4527.728336299832, 1692.6530061337396, 1783.3490775866715, 1786.490850107713, 1820.544863784054, 1860.4001257566651, 865.9997702653445, 881.7619242804407, 890.4746199742183, 942.0014784328633, 973.5083782689696, 15695.764563531557, 16576.502704918872, 16930.746038809426, 17102.315907363816, 17313.2209050593, 884.9336299777542, 896.7444278380631, 918.7657147427363, 925.6066171876926, 932.5803388475214, 9429.2928030398, 9474.810503789886, 9632.422054676741, 9706.70879873605, 9822.361546499455, 242551.0, 246733.0, 247054.0, 392783.0, 397529.0, 51547.742261289204, 80403.59798201089, 81060.0, 81318.0, 83522.0, 935.9017303183203, 936.9906300936904, 962.3456049886005, 963.8409662405625, 971.3831716859845, 15345.156016419203, 15613.453529126426, 15725.921370393075, 15866.0, 16234.26945787466, 29763.107106786832, 30671.846640766653, 34084.82957585196, 35429.645703542636, 35535.28929421449, 46102.769486152356, 46342.30486542637, 46376.0, 46381.53618463907, 46425.30362044639, 7179.210286868545, 7330.523515971445, 7342.70629174827, 7432.591207483641, 7530.510516816389, 7213.026241457336, 9935.850962235716, 10065.496725163859, 11360.488778005174, 11813.40932953366, 9772.169365604002, 9933.950330248303, 10101.44442055694, 10120.038596333337, 10345.37927724339, 9087.227585655293, 9716.3198576099, 9898.455584942898, 10341.586336546454, 10445.268831181744, 6616.0, 8200.589970501333, 10087.193024557871, 10649.787004259717, 10920.344779313267, 7635.389168866366, 7767.650455729618, 7905.6837726492595, 7921.445498815027, 7954.164812694584, 10006.249531285328, 10008.349457285252, 10048.145907597644, 10204.591816327264, 10501.78996420052], "value": 7940.535599339679, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.1418570836095, 1434.949776757813, 1477.4090363854457, 1613.322404590072, 1749.8512626426761, 7405.444591655627, 7732.381409487241, 7743.148253692097, 7744.419168562366, 7747.1090824555195, 7576.659050342734, 7738.110117336508, 7753.806154846132, 7757.922420775791, 7764.18476060014, 1925.5956249187686, 2180.6401943679275, 2213.147938043857, 2246.674232236333, 2247.5954328220914, 2261.7738226177416, 2286.2341115726167, 2290.8167346612313, 2291.713535808024, 2291.942701432469, 2157.6332023555956, 2191.1783081344497, 2220.622494175994, 2223.6664500325, 2228.142165266368, 1743.6599863026652, 2121.745390553128, 2178.716766820319, 2181.6291230490856, 2189.419803752007, 2157.1155826111376, 2159.481724386136, 2161.4164175672636, 2187.048633844283, 2189.058704756954, 7592.468527203098, 7699.653515591812, 7715.074191097048, 7718.343940764986, 7721.922780772233, 4439.356293337481, 4597.42532183477, 4599.011212589276, 4601.723896566184, 4602.838900638461, 2854.0581608069288, 2883.855807209652, 2897.1163795042503, 2912.606798082253, 2967.762578993675, 877.368294827723, 881.0616693221698, 884.4162852517308, 902.3142411767038, 902.8555431130987, 10432.32189907661, 10585.841212381743, 10597.364158150536, 10628.521716522775, 10629.149668026617, 4116.382542618571, 4198.6221240088535, 4344.3049112142535, 4384.561543845653, 4386.254336762758, 8953.820923581492, 8988.820223595492, 9000.36997410175, 9015.053419391, 9024.503652299056, 4742.241241401359, 4748.358971538798, 4759.619230461555, 4768.046390721869, 4783.760811959458, 3710.4434334849448, 4025.255327764373, 4121.423000779893, 4132.690048246393, 4135.193637240769, 3616.8914932552066, 3671.834767435472, 3713.4801127842125, 3808.6953043756434, 3825.6174382562076, 1249.7188132670076, 1254.1283807753707, 1263.91784534005, 1268.2010333490027, 1270.5172034626783, 713.4328209073799, 828.7099515169642, 837.7403005068448, 847.0936098374804, 852.1563651984491, 5206.97396513015, 5223.0, 5406.783728650888, 5487.670739755627, 5506.421825708323, 807.1928071928072, 832.8750687396818, 887.1970866365949, 909.3225546967551, 912.2109375390372, 3619.5656521217097, 3703.703703703697, 3748.700103991674, 3762.548494180716, 3807.790571518593, 8838.381313308135, 8928.821423571491, 9267.304952128483, 9288.702510608771, 9295.442273463614, 9532.046795320413, 9621.27840411972, 9626.229901607994, 9646.710598682052, 9650.565724542412, 7186.10173728284, 7195.7481488148715, 7294.0, 7305.123385193704, 7395.149557800922, 4878.56092951636, 4971.055499455092, 4976.129177394014, 4991.151504244214, 5043.142665746758, 8853.158949900007, 8931.19619234272, 8975.461472311683, 8981.955090224506, 9005.279577633904, 8135.633896474791, 8247.793805154679, 8373.162683731578, 8374.371922105745, 8432.241098301183, 5981.342052374148, 6414.454771344488, 6590.47276217911, 6637.435817955527, 6830.487713421613, 7128.821779455555, 7147.213806481387, 7199.496035277481, 7209.315115064271, 7219.314165154302, 6267.874642507033, 6339.112524246517, 6386.93613063882, 6456.903146452713, 6526.314736952551, 6343.333949935375, 6398.072279519351, 6470.417662410406, 6499.5775274607, 6602.075709400784, 5969.462748352669, 6007.90988135187, 6021.367756385516, 6037.366076562073, 6040.6677632730625, 4370.519242883217, 4567.703099298535, 4630.83792067276, 4695.366125573004, 4736.336912832137, 4329.588689074533, 4333.068390296102, 4339.088791353851, 4417.469903611587, 4438.911221775482], "value": 4100.640233672133, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.1044125051722, 309.874500827165, 314.54862272638763, 315.38814699482987, 316.24259897545363, 4875.439324477687, 4989.850304490862, 4998.55013048826, 5035.370578677665, 5035.546800787933, 4940.555350018498, 4959.454460009396, 4959.9008019839675, 4964.304997300372, 4966.652334336598, 3701.7408781385316, 3757.9248415031684, 3934.252492026506, 3944.3097457944887, 3961.6038396160297, 3898.2788184185874, 3926.6858651307825, 3939.606039396066, 3941.817454763574, 3954.7627142371407, 3610.386234340155, 3879.1465877506903, 3900.609939006091, 3911.2177564487074, 3912.4913761211146, 3783.3568293390053, 3899.78551179685, 3906.374980003214, 3926.2343842950636, 3935.232629637222, 3481.0, 3485.076454739496, 3494.947575786365, 3497.5977762557122, 3502.4921386399083, 4814.975925120387, 4821.397325334333, 4828.589569886564, 4836.395450568679, 4866.0, 4169.0, 4370.322599997005, 4374.409454723604, 4411.647068234533, 4513.616342610882, 5209.7134657593815, 5210.400803907562, 5211.739413029333, 5221.2951251580935, 5227.26818245446, 3708.4066549351974, 3709.610490898444, 3714.3499887519847, 3714.4056950888, 3726.4782930389765, 5173.275741396207, 5423.511883930465, 5505.311836020497, 5510.228568000483, 5535.086710692771, 3791.1848952474797, 3793.563740169916, 3815.351390263662, 3822.694184465236, 3826.483424737625, 3858.440526123696, 3873.903152421212, 3876.476675648808, 3877.0695033192396, 3877.1857909838686, 4278.229918614679, 4422.955770442319, 4424.579664931826, 4427.203103441347, 4444.088961762831, 5245.921311180336, 5250.369955605275, 5269.604779641542, 5269.892043182681, 5274.947250527445, 1319.5183757928287, 1347.4677502386503, 1348.629126990066, 1349.1230700045048, 1354.780697372353, 837.409626213518, 862.8360611483798, 888.1828717579842, 907.4555266839975, 925.3661242049218, 4616.28447590624, 4619.743081127797, 4627.490975992638, 4628.5371462853445, 4643.535646435397, 5370.62405631602, 5376.1935709643085, 5386.596005299618, 5391.622586418992, 5392.299001129906, 4460.7323560586465, 4570.908581828345, 4574.08518296342, 4601.953980460219, 4627.0, 2831.3912508810704, 2831.957520637192, 2838.8012839101066, 2850.2874281429645, 2867.842268675201, 4999.875003124878, 5009.824656137018, 5012.122878496249, 5040.168372218543, 5049.318342023853, 5265.973670131625, 5417.756200970965, 5445.0, 5460.099083651233, 5464.9453505465235, 5021.774020169101, 5038.1183292924325, 5056.6713163644245, 5057.468965758542, 5076.517730815566, 5311.203319502106, 5336.424595521088, 5337.893242135213, 5346.893062138658, 5347.973260133675, 5082.2122571001555, 5210.687358758487, 5377.139657654757, 5384.6769193848495, 5409.459054094559, 5167.58659307247, 5179.274901513866, 5183.896322073613, 5187.144121220107, 5197.454267301879, 3791.8104094795704, 3813.5995720450064, 3818.427235914524, 3822.7706337619834, 3825.540935087807, 5125.513076257749, 5401.567874570103, 5414.918776218438, 5446.945530544803, 5468.671879687232, 5254.79139797841, 5285.894282114259, 5285.894282114413, 5286.656367336111, 5294.629375943647, 5154.304168937146, 5279.868003299948, 5280.524752772269, 5286.233496143114, 5296.867578310573, 5068.695878247317, 5154.278401023935, 5173.456787037307, 5191.506806853343, 5199.4020687621405, 5029.27075574047, 5100.872478188075, 5270.73646317675, 5288.788448462173, 5290.836016076457, 5142.0, 5149.433562308068, 5184.7926082957765, 5187.610929180251, 5194.584433245407], "value": 3943.6966241356645, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.5738741124562, 699.9726184253107, 746.8468963862408, 782.3389236095497, 784.2432053068791, 11422.771544569103, 12244.081693872973, 12262.080343974216, 12265.546890621878, 12270.81593776094, 10557.41934193619, 10626.14990800736, 10669.626563070295, 10695.893041069587, 10720.78558428833, 635.1267007864187, 779.0806847919453, 804.2319584796535, 814.9918500814975, 816.3142959913671, 809.0938149272794, 809.0938149272823, 810.2302812328282, 811.0348685064783, 811.1320886651285, 834.6911642692182, 837.9832403351929, 839.1901814748766, 843.1189407069596, 844.3329769482102, 661.4972620808196, 821.137805304428, 831.1439217605875, 833.7165363776314, 847.6990668312721, 624.0265186309326, 625.6777759453885, 627.1721327847243, 627.5105417774098, 627.7834147219202, 11773.764524709457, 11831.408429578487, 11834.763304733944, 11849.763004739856, 11867.287962722265, 12058.758824823455, 12387.566435174816, 12443.191192572544, 12517.74964500714, 12850.357482125857, 9133.132352426508, 9462.90537094634, 9642.0, 9874.111329980264, 9988.45063521506, 3237.838108094586, 3239.2063944333554, 3248.2853772170083, 3300.504924261356, 3398.9660103398896, 43771.0, 43994.78002609999, 44057.11885762267, 44066.559334406564, 44194.11611767779, 9034.593443295067, 9445.527723613792, 9563.282753793494, 9624.181944534794, 9674.661386851427, 16777.0, 16912.408065717642, 17012.234449449803, 17017.0, 17098.487045388658, 6049.727762250709, 6182.0, 6216.347283535164, 6252.812415627538, 6338.873222535616, 3664.1755604988666, 3779.066874956488, 3804.2771873343977, 3852.768833869921, 3894.8636797711943, 2533.1134103063782, 2645.404783923602, 2648.0334677842447, 2648.9205323840315, 2653.9867300663373, 492.8053418899515, 497.0903247057948, 499.93250911126535, 502.30932467856695, 504.14547342254525, 534.7753943343805, 592.8814237152586, 599.3278752281087, 599.9890730466843, 602.1599868183858, 7335.496223274216, 7824.37405007598, 7938.166492518202, 8068.7175948841505, 8247.876281855777, 459.9310103484504, 557.8912112138175, 561.5180900420153, 605.857623458487, 627.4885967936209, 3726.888193354204, 3866.0721426857913, 3900.726949113535, 3946.1713040261866, 3979.6816254699556, 48914.75542622264, 49575.752121239166, 49707.751461243184, 49814.750926245135, 50400.49599504031, 42953.78523107364, 43305.35041974373, 44399.778001109786, 44648.0, 44788.55211447909, 39720.0, 40169.0, 40238.19523609511, 40516.0, 40866.9783255415, 7885.211478852299, 7981.680732770624, 8135.67457301725, 8183.754487365389, 8281.503109813431, 25817.612735809354, 25967.350816229744, 26251.73748262493, 26381.736182637927, 26718.465630687668, 34820.0, 34942.301153977285, 36214.8189259052, 36432.08919777027, 36885.81557092305, 10500.317479364123, 10575.36547807134, 10654.200934929757, 10752.83870741955, 10795.19036072282, 11448.656540303471, 11491.885081149081, 12074.879251207376, 12312.569060082855, 12327.815082773586, 10730.463476826284, 10776.407297598395, 10987.340759554452, 11073.390963497084, 11184.776304474028, 10131.64539241123, 10169.186465082628, 10234.590616375262, 10470.842937355794, 10762.085222756154, 10269.794604107727, 10387.84418233712, 10567.418791966516, 10645.041946224877, 10821.404822734825, 9751.804963900824, 9757.414555126716, 9884.406935583887, 9948.701538953843, 10498.055175034284, 9648.517574121406, 9937.850932235877, 9940.751481213027, 9983.101520863158, 10000.0], "value": 5773.633111100546, "unit": "score"}], "name": "dromaeo_css", "value": 6249.204744108998, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 110.0, 113.0, 114.0, 113.0, 104.0, 113.0, 113.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 139.0, 156.0, 195.0, 140.0, 159.0, 172.0, 134.0, 193.0, 139.0], "value": 159.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 159.0, 161.0, 163.0, 162.0, 161.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 104.0, 110.0, 77.0, 77.0, 74.0, 115.0, 105.0, 73.0], "value": 88.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 141.0, 93.0, 94.0, 94.0, 155.0, 93.0, 95.0, 143.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 116.0, 117.0, 118.0, 117.0, 118.0, 117.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.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, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 66.0, 64.0, 65.0, 66.0, 83.0, 64.0, 64.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 77.0, 78.0, 80.0, 78.0, 80.0, 80.0, 80.0, 80.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 142.0, 143.0, 131.0, 129.0, 133.0, 134.0, 129.0, 165.0, 135.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 170.0, 170.0, 180.0, 176.0, 172.0, 178.0, 177.0, 182.0], "value": 175.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 75.0, 72.0, 72.0, 71.0, 70.0, 72.0, 71.0], "value": 71.8, "unit": "score"}], "name": "kraken", "value": 1584.0, "alertThreshold": 2.0}]} 03:51:55 INFO - Return code: 0 03:51:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:51:55 ERROR - # TBPL SUCCESS # 03:51:55 INFO - Running post-action listener: _resource_record_post_action 03:51:55 INFO - Running post-run listener: _resource_record_post_run 03:51:56 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 516825088; Read time: 8; Write time: 626808 03:51:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232034304; Read time: 0; Write time: 304852 03:51:56 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282980352; Read time: 8; Write time: 321796 03:51:56 INFO - Running post-run listener: _upload_blobber_files 03:51:56 INFO - Blob upload gear active. 03:51:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:51:56 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'] 03:51:56 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 03:51:56 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:51:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:51:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:57 INFO - (blobuploader) - INFO - Done attempting. 03:51:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:51:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:51:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:58 INFO - (blobuploader) - INFO - Done attempting. 03:51:58 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:58 INFO - Return code: 0 03:51:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ecdce0169c672192e92d104c39939670bc2a9904679fa0f3156c908846efd4b36c076ac246b8ae6bb07af8bf5ec915e251072eab1321592d13aa6b9a044e20e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e81ec20083ddee2956edf32d81afc3aedc898a52a127a801f3100dd8e90ebc9fbaa87eb8d9d7562ed69e25c37d02ce702594ee34cc25af8c91bb3241bad0f17"} 03:51:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:58 INFO - Contents: 03:51:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ecdce0169c672192e92d104c39939670bc2a9904679fa0f3156c908846efd4b36c076ac246b8ae6bb07af8bf5ec915e251072eab1321592d13aa6b9a044e20e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e81ec20083ddee2956edf32d81afc3aedc898a52a127a801f3100dd8e90ebc9fbaa87eb8d9d7562ed69e25c37d02ce702594ee34cc25af8c91bb3241bad0f17"} 03:51:58 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:58 INFO - Copying logs to upload dir... 03:51:58 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.619043 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-19 03:51:57.830619) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 03:51:57.834464) ========= 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=232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622 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/ecdce0169c672192e92d104c39939670bc2a9904679fa0f3156c908846efd4b36c076ac246b8ae6bb07af8bf5ec915e251072eab1321592d13aa6b9a044e20e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e81ec20083ddee2956edf32d81afc3aedc898a52a127a801f3100dd8e90ebc9fbaa87eb8d9d7562ed69e25c37d02ce702594ee34cc25af8c91bb3241bad0f17"} build_url:https://queue.taskcluster.net/v1/task/Pk5PpSdjT_OINrr5cnZMrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011184 build_url: 'https://queue.taskcluster.net/v1/task/Pk5PpSdjT_OINrr5cnZMrg/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/ecdce0169c672192e92d104c39939670bc2a9904679fa0f3156c908846efd4b36c076ac246b8ae6bb07af8bf5ec915e251072eab1321592d13aa6b9a044e20e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e81ec20083ddee2956edf32d81afc3aedc898a52a127a801f3100dd8e90ebc9fbaa87eb8d9d7562ed69e25c37d02ce702594ee34cc25af8c91bb3241bad0f17"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 03:51:57.858597) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:51:57.858900) ========= 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=232498196343f89f466a4a9a000001c8-1461061876.532631-1490118622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004369 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 03:51:57.943379) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 03:51:57.943680) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 03:51:57.943954) ========= ========= Total master_lag: 0.16 =========