builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1461339907.64 results: success (0) buildid: 20160422053010 builduid: 5d8caa1e22754b788b9fc60c91101690 revision: 4ca15e44f0b59c06d35b776320cb149e2422a2fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 08:45:07.644875) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 08:45:07.646248) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 08:45:07.646677) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 08:45:07.662935) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:45:07.663288) ========= 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=1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 08:45:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-04-22 08:45:08 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124808 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:45:07.801921) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:45:07.802249) ========= 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=1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018456 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:45:07.851891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:45:07.852311) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4ca15e44f0b59c06d35b776320cb149e2422a2fc --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 4ca15e44f0b59c06d35b776320cb149e2422a2fc --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=1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 08:45:08,601 truncating revision to first 12 chars 2016-04-22 08:45:08,601 Setting DEBUG logging. 2016-04-22 08:45:08,601 attempt 1/10 2016-04-22 08:45:08,601 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4ca15e44f0b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 08:45:08,823 unpacking tar archive at: fx-team-4ca15e44f0b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.505518 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:45:08.370711) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 08:45:08.371033) ========= script_repo_revision: 4ca15e44f0b59c06d35b776320cb149e2422a2fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 08:45:08.371512) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 08:45:08.371784) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 08:45:08.381222) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-04-22 08:45:08.381559) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:45:09 INFO - MultiFileLogger online at 20160422 08:45:09 in /builds/slave/test 08:45:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:45:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:45:09 INFO - {'append_to_log': False, 08:45:09 INFO - 'base_work_dir': '/builds/slave/test', 08:45:09 INFO - 'blob_upload_branch': 'Fx-Team', 08:45:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:45:09 INFO - 'branch': 'Fx-Team', 08:45:09 INFO - 'buildbot_json_path': 'buildprops.json', 08:45:09 INFO - 'config_files': ('talos/linux_config.py',), 08:45:09 INFO - 'default_actions': ('clobber', 08:45:09 INFO - 'read-buildbot-config', 08:45:09 INFO - 'download-and-extract', 08:45:09 INFO - 'populate-webroot', 08:45:09 INFO - 'create-virtualenv', 08:45:09 INFO - 'install', 08:45:09 INFO - 'run-tests'), 08:45:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:45:09 INFO - 'download_minidump_stackwalk': True, 08:45:09 INFO - 'download_symbols': 'ondemand', 08:45:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:45:09 INFO - 'tooltool.py': '/tools/tooltool.py', 08:45:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:45:09 INFO - '/tools/misc-python/virtualenv.py')}, 08:45:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:45:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:45:09 INFO - 'installer_path': 'installer.exe', 08:45:09 INFO - 'log_level': 'info', 08:45:09 INFO - 'log_name': 'talos', 08:45:09 INFO - 'log_to_console': True, 08:45:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:45:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:45:09 INFO - 'opt_config_files': (), 08:45:09 INFO - 'pip_index': False, 08:45:09 INFO - 'sps_profile': False, 08:45:09 INFO - 'sps_profile_interval': 0, 08:45:09 INFO - 'suite': 'dromaeojs-e10s', 08:45:09 INFO - 'system_bits': '32', 08:45:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:45:09 INFO - 'title': 'talos-linux64-ix-027', 08:45:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:45:09 INFO - 'use_talos_json': True, 08:45:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:45:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:45:09 INFO - 'work_dir': 'build'} 08:45:09 INFO - ##### 08:45:09 INFO - ##### Running clobber step. 08:45:09 INFO - ##### 08:45:09 INFO - Running pre-action listener: _resource_record_pre_action 08:45:09 INFO - Running main action method: clobber 08:45:09 INFO - rmtree: /builds/slave/test/build 08:45:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:45:10 INFO - Running post-action listener: _resource_record_post_action 08:45:10 INFO - ##### 08:45:10 INFO - ##### Running read-buildbot-config step. 08:45:10 INFO - ##### 08:45:10 INFO - Running pre-action listener: _resource_record_pre_action 08:45:10 INFO - Running main action method: read_buildbot_config 08:45:10 INFO - Using buildbot properties: 08:45:10 INFO - { 08:45:10 INFO - "project": "", 08:45:10 INFO - "product": "firefox", 08:45:10 INFO - "script_repo_revision": "production", 08:45:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:45:10 INFO - "repository": "", 08:45:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:45:10 INFO - "buildid": "20160422053010", 08:45:10 INFO - "pgo_build": "True", 08:45:10 INFO - "basedir": "/builds/slave/test", 08:45:10 INFO - "buildnumber": 681, 08:45:10 INFO - "slavename": "talos-linux64-ix-027", 08:45:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:45:10 INFO - "platform": "ubuntu64_hw", 08:45:10 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:45:10 INFO - "branch": "fx-team", 08:45:10 INFO - "repo_path": "integration/fx-team", 08:45:10 INFO - "revision": "4ca15e44f0b59c06d35b776320cb149e2422a2fc", 08:45:10 INFO - "stage_platform": "linux64-pgo", 08:45:10 INFO - "builduid": "5d8caa1e22754b788b9fc60c91101690", 08:45:10 INFO - "slavebuilddir": "test" 08:45:10 INFO - } 08:45:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:45:10 INFO - Running post-action listener: _resource_record_post_action 08:45:10 INFO - ##### 08:45:10 INFO - ##### Running download-and-extract step. 08:45:10 INFO - ##### 08:45:10 INFO - Running pre-action listener: _resource_record_pre_action 08:45:10 INFO - Running main action method: download_and_extract 08:45:10 INFO - mkdir: /builds/slave/test/build/tests 08:45:10 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')]} 08:45:10 INFO - https://queue.taskcluster.net/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:45:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:45:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:45:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/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 08:45:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/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 08:45:10 INFO - Downloaded 1361 bytes. 08:45:10 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:45:10 INFO - Using the following test package requirements: 08:45:10 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:45:10 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:45:10 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:45:10 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:10 INFO - u'jsshell-linux-x86_64.zip'], 08:45:10 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:45:10 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:45:10 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:45:10 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:45:10 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:45:10 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:45:10 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:45:10 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')]} 08:45:10 INFO - https://queue.taskcluster.net/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:45:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:45:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:45:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/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 08:45:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/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 08:45:12 INFO - Downloaded 23853527 bytes. 08:45:12 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'] 08:45:12 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 08:45:13 INFO - Return code: 0 08:45:13 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 08:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:13 INFO - https://queue.taskcluster.net/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:45:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:45:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:45:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/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 08:45:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/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 08:45:16 INFO - Downloaded 23853527 bytes. 08:45:16 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'] 08:45:16 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 08:45:17 INFO - Return code: 0 08:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:17 INFO - https://queue.taskcluster.net/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:45:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:45:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:45:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/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 08:45:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/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 08:45:19 INFO - Downloaded 10845952 bytes. 08:45:19 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'] 08:45:19 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 08:45:19 INFO - Return code: 0 08:45: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')]} 08:45:19 INFO - https://queue.taskcluster.net/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:45:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:45:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:45:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/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 08:45:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PCynQOaYSaqsENK_AeK-MA/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 08:45:21 INFO - Downloaded 58314787 bytes. 08:45:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:45:21 INFO - mkdir: /builds/slave/test/properties 08:45:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:45:21 INFO - Writing to file /builds/slave/test/properties/build_url 08:45:21 INFO - Contents: 08:45:21 INFO - build_url:https://queue.taskcluster.net/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:45:21 INFO - Running post-action listener: _resource_record_post_action 08:45:21 INFO - Running post-action listener: set_extra_try_arguments 08:45:21 INFO - ##### 08:45:21 INFO - ##### Running populate-webroot step. 08:45:21 INFO - ##### 08:45:21 INFO - Running pre-action listener: _resource_record_pre_action 08:45:21 INFO - Running main action method: populate_webroot 08:45:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:45:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:45:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:45:21 INFO - '--tppagecycles', 08:45:21 INFO - '7'], 08:45:21 INFO - 'tests': ['tsvgm']}}, 08:45:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:45:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:45:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:45:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:45:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:45:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:45:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:21 INFO - 'talos_options': ['--disable-e10s'], 08:45:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:21 INFO - 'talos_options': ['--disable-e10s'], 08:45:21 INFO - 'tests': ['damp', 'tps']}, 08:45:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:21 INFO - 'tests': ['damp', 'tps']}, 08:45:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:45:21 INFO - 'tests': ['dromaeo_dom']}, 08:45:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:45:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:45:21 INFO - 'tests': ['a11yr', 08:45:21 INFO - 'ts_paint', 08:45:21 INFO - 'tpaint', 08:45:21 INFO - 'sessionrestore', 08:45:21 INFO - 'sessionrestore_no_auto_restore', 08:45:21 INFO - 'tabpaint']}, 08:45:21 INFO - 'other-e10s': {'tests': ['a11yr', 08:45:21 INFO - 'ts_paint', 08:45:21 INFO - 'tpaint', 08:45:21 INFO - 'sessionrestore', 08:45:21 INFO - 'sessionrestore_no_auto_restore', 08:45:21 INFO - 'tabpaint']}, 08:45:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:45:21 INFO - 'ts_paint', 08:45:21 INFO - 'tpaint', 08:45:21 INFO - 'sessionrestore', 08:45:21 INFO - 'sessionrestore_no_auto_restore', 08:45:21 INFO - 'tabpaint']}, 08:45:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:45:21 INFO - 'ts_paint', 08:45:21 INFO - 'tpaint', 08:45:21 INFO - 'sessionrestore', 08:45:21 INFO - 'sessionrestore_no_auto_restore', 08:45:21 INFO - 'tabpaint']}, 08:45:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:45:21 INFO - 'tests': ['a11yr', 08:45:21 INFO - 'ts_paint', 08:45:21 INFO - 'tpaint', 08:45:21 INFO - 'sessionrestore', 08:45:21 INFO - 'sessionrestore_no_auto_restore', 08:45:21 INFO - 'tabpaint']}, 08:45:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:45:21 INFO - 'tests': ['a11yr', 08:45:21 INFO - 'ts_paint', 08:45:21 INFO - 'tpaint', 08:45:21 INFO - 'sessionrestore', 08:45:21 INFO - 'sessionrestore_no_auto_restore', 08:45:21 INFO - 'tabpaint']}, 08:45:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:45:21 INFO - 'tests': ['tsvgx', 08:45:21 INFO - 'tsvgr_opacity', 08:45:21 INFO - 'tart', 08:45:21 INFO - 'tscrollx', 08:45:21 INFO - 'cart']}, 08:45:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:45:21 INFO - 'tsvgr_opacity', 08:45:21 INFO - 'tart', 08:45:21 INFO - 'tscrollx', 08:45:21 INFO - 'cart']}, 08:45:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:21 INFO - 'talos_options': ['--disable-e10s'], 08:45:21 INFO - 'tests': ['tp5o']}, 08:45:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:21 INFO - 'tests': ['tp5o']}, 08:45:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:21 INFO - 'talos_options': ['--disable-e10s', 08:45:21 INFO - '--xperf_path', 08:45:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:21 INFO - 'tests': ['tp5n']}, 08:45:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:21 INFO - 'talos_options': ['--xperf_path', 08:45:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:21 INFO - 'tests': ['tp5n']}}, 08:45:21 INFO - 'talos.zip': {'path': '', 08:45:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:45:21 INFO - Running post-action listener: _resource_record_post_action 08:45:21 INFO - ##### 08:45:21 INFO - ##### Running create-virtualenv step. 08:45:21 INFO - ##### 08:45:21 INFO - Running pre-action listener: _resource_record_pre_action 08:45:21 INFO - Running main action method: create_virtualenv 08:45:21 INFO - Creating virtualenv /builds/slave/test/build/venv 08:45:21 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 08:45:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:45:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:45:21 INFO - Using real prefix '/usr' 08:45:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:45:22 INFO - Installing distribute.............................................................................................................................................................................................done. 08:45:24 INFO - Installing pip.................done. 08:45:24 INFO - Return code: 0 08:45:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:24 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 0x7f4899d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4410>, '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 0x14a5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a57a0>, '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': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', '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 08:45:24 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 08:45:24 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 08:45:24 INFO - Using env: {'DISPLAY': ':0', 08:45:24 INFO - 'HOME': '/home/cltbld', 08:45:24 INFO - 'LANG': 'en_US.UTF-8', 08:45:24 INFO - 'LANGUAGE': 'en_US:en', 08:45:24 INFO - 'LOGNAME': 'cltbld', 08:45:24 INFO - 'MAIL': '/var/mail/cltbld', 08:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:24 INFO - 'MOZ_NO_REMOTE': '1', 08:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:24 INFO - 'NO_EM_RESTART': '1', 08:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:24 INFO - 'PWD': '/builds/slave/test', 08:45:24 INFO - 'SHELL': '/bin/bash', 08:45:24 INFO - 'SHLVL': '1', 08:45:24 INFO - 'TERM': 'linux', 08:45:24 INFO - 'TMOUT': '86400', 08:45:24 INFO - 'USER': 'cltbld', 08:45:24 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', 08:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:24 INFO - '_': '/tools/buildbot/bin/python'} 08:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:24 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 08:45:24 INFO - Cleaning up... 08:45:24 INFO - Return code: 0 08:45:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:24 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 0x7f4899d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4410>, '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 0x14a5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a57a0>, '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': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', '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 08:45:24 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 08:45:24 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 08:45:24 INFO - Using env: {'DISPLAY': ':0', 08:45:24 INFO - 'HOME': '/home/cltbld', 08:45:24 INFO - 'LANG': 'en_US.UTF-8', 08:45:24 INFO - 'LANGUAGE': 'en_US:en', 08:45:24 INFO - 'LOGNAME': 'cltbld', 08:45:24 INFO - 'MAIL': '/var/mail/cltbld', 08:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:24 INFO - 'MOZ_NO_REMOTE': '1', 08:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:24 INFO - 'NO_EM_RESTART': '1', 08:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:24 INFO - 'PWD': '/builds/slave/test', 08:45:24 INFO - 'SHELL': '/bin/bash', 08:45:24 INFO - 'SHLVL': '1', 08:45:24 INFO - 'TERM': 'linux', 08:45:24 INFO - 'TMOUT': '86400', 08:45:24 INFO - 'USER': 'cltbld', 08:45:24 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', 08:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:24 INFO - '_': '/tools/buildbot/bin/python'} 08:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:24 INFO - Downloading/unpacking psutil>=0.7.1 08:45:24 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 08:45:24 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 08:45:24 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 08:45:24 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 08:45:24 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 08:45:24 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 08:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:45:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:26 INFO - Installing collected packages: psutil 08:45:26 INFO - Running setup.py install for psutil 08:45:26 INFO - building 'psutil._psutil_linux' extension 08:45:26 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 08:45:27 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 08:45:27 INFO - building 'psutil._psutil_posix' extension 08:45:27 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 08:45:27 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 08:45:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:27 INFO - Successfully installed psutil 08:45:27 INFO - Cleaning up... 08:45:27 INFO - Return code: 0 08:45:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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')]} 08:45:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4899d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4410>, '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 0x14a5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a57a0>, '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': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', '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 08:45:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:45:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:45:27 INFO - Using env: {'DISPLAY': ':0', 08:45:27 INFO - 'HOME': '/home/cltbld', 08:45:27 INFO - 'LANG': 'en_US.UTF-8', 08:45:27 INFO - 'LANGUAGE': 'en_US:en', 08:45:27 INFO - 'LOGNAME': 'cltbld', 08:45:27 INFO - 'MAIL': '/var/mail/cltbld', 08:45:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:27 INFO - 'MOZ_NO_REMOTE': '1', 08:45:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:27 INFO - 'NO_EM_RESTART': '1', 08:45:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:27 INFO - 'PWD': '/builds/slave/test', 08:45:27 INFO - 'SHELL': '/bin/bash', 08:45:27 INFO - 'SHLVL': '1', 08:45:27 INFO - 'TERM': 'linux', 08:45:27 INFO - 'TMOUT': '86400', 08:45:27 INFO - 'USER': 'cltbld', 08:45:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', 08:45:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:27 INFO - '_': '/tools/buildbot/bin/python'} 08:45:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:45:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:45:29 INFO - Installing collected packages: mozsystemmonitor 08:45:29 INFO - Running setup.py install for mozsystemmonitor 08:45:29 INFO - Successfully installed mozsystemmonitor 08:45:29 INFO - Cleaning up... 08:45:29 INFO - Return code: 0 08:45:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4899d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4410>, '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 0x14a5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a57a0>, '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': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', '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 08:45:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:45:29 INFO - Using env: {'DISPLAY': ':0', 08:45:29 INFO - 'HOME': '/home/cltbld', 08:45:29 INFO - 'LANG': 'en_US.UTF-8', 08:45:29 INFO - 'LANGUAGE': 'en_US:en', 08:45:29 INFO - 'LOGNAME': 'cltbld', 08:45:29 INFO - 'MAIL': '/var/mail/cltbld', 08:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:29 INFO - 'MOZ_NO_REMOTE': '1', 08:45:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:29 INFO - 'NO_EM_RESTART': '1', 08:45:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:29 INFO - 'PWD': '/builds/slave/test', 08:45:29 INFO - 'SHELL': '/bin/bash', 08:45:29 INFO - 'SHLVL': '1', 08:45:29 INFO - 'TERM': 'linux', 08:45:29 INFO - 'TMOUT': '86400', 08:45:29 INFO - 'USER': 'cltbld', 08:45:29 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', 08:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:29 INFO - '_': '/tools/buildbot/bin/python'} 08:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:29 INFO - Downloading/unpacking blobuploader==1.2.4 08:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:31 INFO - Downloading blobuploader-1.2.4.tar.gz 08:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:45:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:45:31 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 08:45:31 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 08:45:31 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 08:45:31 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 08:45:31 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 08:45:31 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 08:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:45:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:32 INFO - Downloading docopt-0.6.1.tar.gz 08:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:45:32 INFO - Installing collected packages: blobuploader, requests, docopt 08:45:32 INFO - Running setup.py install for blobuploader 08:45:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:45:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:45:32 INFO - Running setup.py install for requests 08:45:32 INFO - Running setup.py install for docopt 08:45:33 INFO - Successfully installed blobuploader requests docopt 08:45:33 INFO - Cleaning up... 08:45:33 INFO - Return code: 0 08:45:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:33 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')]} 08:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:33 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')]} 08:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:33 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 0x7f4899d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4410>, '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 0x14a5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a57a0>, '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': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', '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 08:45:33 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 08:45:33 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 08:45:33 INFO - Using env: {'DISPLAY': ':0', 08:45:33 INFO - 'HOME': '/home/cltbld', 08:45:33 INFO - 'LANG': 'en_US.UTF-8', 08:45:33 INFO - 'LANGUAGE': 'en_US:en', 08:45:33 INFO - 'LOGNAME': 'cltbld', 08:45:33 INFO - 'MAIL': '/var/mail/cltbld', 08:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:33 INFO - 'MOZ_NO_REMOTE': '1', 08:45:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:33 INFO - 'NO_EM_RESTART': '1', 08:45:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:33 INFO - 'PWD': '/builds/slave/test', 08:45:33 INFO - 'SHELL': '/bin/bash', 08:45:33 INFO - 'SHLVL': '1', 08:45:33 INFO - 'TERM': 'linux', 08:45:33 INFO - 'TMOUT': '86400', 08:45:33 INFO - 'USER': 'cltbld', 08:45:33 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', 08:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:33 INFO - '_': '/tools/buildbot/bin/python'} 08:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:33 INFO - Running setup.py (path:/tmp/pip-qEV9RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:33 INFO - Running setup.py (path:/tmp/pip-4hZXl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:33 INFO - Running setup.py (path:/tmp/pip-xV2xy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:33 INFO - Running setup.py (path:/tmp/pip-HO9fXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:33 INFO - Running setup.py (path:/tmp/pip-_STRFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:33 INFO - Running setup.py (path:/tmp/pip-M8ZjCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:33 INFO - Running setup.py (path:/tmp/pip-4TVrtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:33 INFO - Running setup.py (path:/tmp/pip-fup4nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:33 INFO - Running setup.py (path:/tmp/pip-FihQya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:33 INFO - Running setup.py (path:/tmp/pip-Dq_Q8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:34 INFO - Running setup.py (path:/tmp/pip-1iWxal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:34 INFO - Running setup.py (path:/tmp/pip-2By4cZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:34 INFO - Running setup.py (path:/tmp/pip-bHh1fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:34 INFO - Running setup.py (path:/tmp/pip-rnUbAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:34 INFO - Running setup.py (path:/tmp/pip-b7e2tK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:34 INFO - Running setup.py (path:/tmp/pip-2TzS1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:34 INFO - Running setup.py (path:/tmp/pip-TzRMfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:45:34 INFO - Running setup.py install for manifestparser 08:45:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:45:34 INFO - Running setup.py install for mozcrash 08:45:34 INFO - Running setup.py install for mozdebug 08:45:34 INFO - Running setup.py install for mozdevice 08:45:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:45:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:45:34 INFO - Running setup.py install for mozfile 08:45:35 INFO - Running setup.py install for mozhttpd 08:45:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:45:35 INFO - Running setup.py install for mozinfo 08:45:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:45:35 INFO - Running setup.py install for mozInstall 08:45:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:45:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:45:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:45:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:45:35 INFO - Running setup.py install for mozleak 08:45:35 INFO - Running setup.py install for mozlog 08:45:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:45:35 INFO - Running setup.py install for moznetwork 08:45:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:45:35 INFO - Running setup.py install for mozprocess 08:45:35 INFO - Running setup.py install for mozprofile 08:45:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:45:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:45:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:45:35 INFO - Running setup.py install for mozrunner 08:45:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:45:36 INFO - Running setup.py install for mozscreenshot 08:45:36 INFO - Running setup.py install for moztest 08:45:36 INFO - Running setup.py install for mozversion 08:45:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:45:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:45:36 INFO - Cleaning up... 08:45:36 INFO - Return code: 0 08:45:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:36 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 0x7f4899d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4410>, '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 0x14a5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a57a0>, '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': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', '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 08:45:36 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 08:45:36 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 08:45:36 INFO - Using env: {'DISPLAY': ':0', 08:45:36 INFO - 'HOME': '/home/cltbld', 08:45:36 INFO - 'LANG': 'en_US.UTF-8', 08:45:36 INFO - 'LANGUAGE': 'en_US:en', 08:45:36 INFO - 'LOGNAME': 'cltbld', 08:45:36 INFO - 'MAIL': '/var/mail/cltbld', 08:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:36 INFO - 'MOZ_NO_REMOTE': '1', 08:45:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:36 INFO - 'NO_EM_RESTART': '1', 08:45:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:36 INFO - 'PWD': '/builds/slave/test', 08:45:36 INFO - 'SHELL': '/bin/bash', 08:45:36 INFO - 'SHLVL': '1', 08:45:36 INFO - 'TERM': 'linux', 08:45:36 INFO - 'TMOUT': '86400', 08:45:36 INFO - 'USER': 'cltbld', 08:45:36 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', 08:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:36 INFO - '_': '/tools/buildbot/bin/python'} 08:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:36 INFO - Running setup.py (path:/tmp/pip-7Kw9d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:36 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)) 08:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:36 INFO - Running setup.py (path:/tmp/pip-0XgbRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:36 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)) 08:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:36 INFO - Running setup.py (path:/tmp/pip-_pltXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:36 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)) 08:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:36 INFO - Running setup.py (path:/tmp/pip-TsfnZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:36 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)) 08:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:36 INFO - Running setup.py (path:/tmp/pip-sCvX1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:36 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)) 08:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:36 INFO - Running setup.py (path:/tmp/pip-m0g4WO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:36 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)) 08:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:36 INFO - Running setup.py (path:/tmp/pip-c0dpAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:37 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)) 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:37 INFO - Running setup.py (path:/tmp/pip-RkuP_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:37 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)) 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:37 INFO - Running setup.py (path:/tmp/pip-vID7ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:37 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)) 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:37 INFO - Running setup.py (path:/tmp/pip-JD4c9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:37 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)) 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:37 INFO - Running setup.py (path:/tmp/pip-R_Kkyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:37 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)) 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:37 INFO - Running setup.py (path:/tmp/pip-ke2LIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:37 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)) 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:37 INFO - Running setup.py (path:/tmp/pip-jfZK9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:37 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)) 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:37 INFO - Running setup.py (path:/tmp/pip-edqobo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:37 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)) 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:37 INFO - Running setup.py (path:/tmp/pip-qO3TIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:37 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)) 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:37 INFO - Running setup.py (path:/tmp/pip-3V7Cja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:37 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)) 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:37 INFO - Running setup.py (path:/tmp/pip-wf4mjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:37 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)) 08:45:37 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)) 08:45:37 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)) 08:45:37 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)) 08:45:37 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)) 08:45:37 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)) 08:45:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:39 INFO - Downloading blessings-1.6.tar.gz 08:45:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:45:39 INFO - Installing collected packages: blessings 08:45:39 INFO - Running setup.py install for blessings 08:45:39 INFO - Successfully installed blessings 08:45:39 INFO - Cleaning up... 08:45:39 INFO - Return code: 0 08:45:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:45:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:40 INFO - Reading from file tmpfile_stdout 08:45:40 INFO - Current package versions: 08:45:40 INFO - argparse == 1.2.1 08:45:40 INFO - blessings == 1.6 08:45:40 INFO - blobuploader == 1.2.4 08:45:40 INFO - docopt == 0.6.1 08:45:40 INFO - manifestparser == 1.1 08:45:40 INFO - mozInstall == 1.12 08:45:40 INFO - mozcrash == 0.17 08:45:40 INFO - mozdebug == 0.1 08:45:40 INFO - mozdevice == 0.48 08:45:40 INFO - mozfile == 1.2 08:45:40 INFO - mozhttpd == 0.7 08:45:40 INFO - mozinfo == 0.9 08:45:40 INFO - mozleak == 0.1 08:45:40 INFO - mozlog == 3.1 08:45:40 INFO - moznetwork == 0.27 08:45:40 INFO - mozprocess == 0.22 08:45:40 INFO - mozprofile == 0.28 08:45:40 INFO - mozrunner == 6.11 08:45:40 INFO - mozscreenshot == 0.1 08:45:40 INFO - mozsystemmonitor == 0.0 08:45:40 INFO - moztest == 0.7 08:45:40 INFO - mozversion == 1.4 08:45:40 INFO - psutil == 3.1.1 08:45:40 INFO - requests == 1.2.3 08:45:40 INFO - wsgiref == 0.1.2 08:45:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:40 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')]} 08:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:40 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')]} 08:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:40 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 0x7f4899d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4410>, '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 0x14a5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a57a0>, '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': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', '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 08:45:40 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 08:45:40 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 08:45:40 INFO - Using env: {'DISPLAY': ':0', 08:45:40 INFO - 'HOME': '/home/cltbld', 08:45:40 INFO - 'LANG': 'en_US.UTF-8', 08:45:40 INFO - 'LANGUAGE': 'en_US:en', 08:45:40 INFO - 'LOGNAME': 'cltbld', 08:45:40 INFO - 'MAIL': '/var/mail/cltbld', 08:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:40 INFO - 'MOZ_NO_REMOTE': '1', 08:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:40 INFO - 'NO_EM_RESTART': '1', 08:45:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:40 INFO - 'PWD': '/builds/slave/test', 08:45:40 INFO - 'SHELL': '/bin/bash', 08:45:40 INFO - 'SHLVL': '1', 08:45:40 INFO - 'TERM': 'linux', 08:45:40 INFO - 'TMOUT': '86400', 08:45:40 INFO - 'USER': 'cltbld', 08:45:40 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', 08:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:40 INFO - '_': '/tools/buildbot/bin/python'} 08:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:40 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)) 08:45:40 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)) 08:45:40 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)) 08:45:40 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)) 08:45:40 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)) 08:45:40 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)) 08:45:40 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)) 08:45:40 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)) 08:45:40 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)) 08:45:40 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)) 08:45:40 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)) 08:45:40 INFO - Cleaning up... 08:45:40 INFO - Return code: 0 08:45:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:45:40 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')]} 08:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:40 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')]} 08:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:40 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 0x7f4899d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4410>, '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 0x14a5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a57a0>, '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': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', '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 08:45:40 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 08:45:40 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 08:45:40 INFO - Using env: {'DISPLAY': ':0', 08:45:40 INFO - 'HOME': '/home/cltbld', 08:45:40 INFO - 'LANG': 'en_US.UTF-8', 08:45:40 INFO - 'LANGUAGE': 'en_US:en', 08:45:40 INFO - 'LOGNAME': 'cltbld', 08:45:40 INFO - 'MAIL': '/var/mail/cltbld', 08:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:40 INFO - 'MOZ_NO_REMOTE': '1', 08:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:40 INFO - 'NO_EM_RESTART': '1', 08:45:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:40 INFO - 'PWD': '/builds/slave/test', 08:45:40 INFO - 'SHELL': '/bin/bash', 08:45:40 INFO - 'SHLVL': '1', 08:45:40 INFO - 'TERM': 'linux', 08:45:40 INFO - 'TMOUT': '86400', 08:45:40 INFO - 'USER': 'cltbld', 08:45:40 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', 08:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:40 INFO - '_': '/tools/buildbot/bin/python'} 08:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:40 INFO - Downloading/unpacking jsonschema 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:45:42 INFO - Downloading/unpacking functools32 (from jsonschema) 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:42 INFO - Downloading functools32-3.2.3-2.tar.gz 08:45:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:45:42 INFO - warning: no files found matching '*.txt' 08:45:42 INFO - no previously-included directories found matching 'build' 08:45:42 INFO - no previously-included directories found matching 'dist' 08:45:42 INFO - no previously-included directories found matching '.git*' 08:45:42 INFO - Installing collected packages: jsonschema, functools32 08:45:42 INFO - Running setup.py install for functools32 08:45:42 INFO - warning: no files found matching '*.txt' 08:45:42 INFO - no previously-included directories found matching 'build' 08:45:42 INFO - no previously-included directories found matching 'dist' 08:45:42 INFO - no previously-included directories found matching '.git*' 08:45:42 INFO - Successfully installed jsonschema functools32 08:45:42 INFO - Cleaning up... 08:45:42 INFO - Return code: 0 08:45:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:45:42 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')]} 08:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:42 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')]} 08:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:42 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 0x7f4899d38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14155a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a4410>, '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 0x14a5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a57a0>, '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': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', '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 08:45:42 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 08:45:42 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 08:45:42 INFO - Using env: {'DISPLAY': ':0', 08:45:42 INFO - 'HOME': '/home/cltbld', 08:45:42 INFO - 'LANG': 'en_US.UTF-8', 08:45:42 INFO - 'LANGUAGE': 'en_US:en', 08:45:42 INFO - 'LOGNAME': 'cltbld', 08:45:42 INFO - 'MAIL': '/var/mail/cltbld', 08:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:42 INFO - 'MOZ_NO_REMOTE': '1', 08:45:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:42 INFO - 'NO_EM_RESTART': '1', 08:45:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:42 INFO - 'PWD': '/builds/slave/test', 08:45:42 INFO - 'SHELL': '/bin/bash', 08:45:42 INFO - 'SHLVL': '1', 08:45:42 INFO - 'TERM': 'linux', 08:45:42 INFO - 'TMOUT': '86400', 08:45:42 INFO - 'USER': 'cltbld', 08:45:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', 08:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:42 INFO - '_': '/tools/buildbot/bin/python'} 08:45:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:43 INFO - Downloading/unpacking flake8 08:45:43 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 08:45:43 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 08:45:43 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 08:45:43 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 08:45:43 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 08:45:43 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 08:45:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:45:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:45:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:45:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:45:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:45:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:45:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:45:45 INFO - no previously-included directories found matching 'docs/_build' 08:45:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:45:45 INFO - Running setup.py install for pep8 08:45:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:45:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:45:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:45:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:45:45 INFO - no previously-included directories found matching 'docs/_build' 08:45:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:45:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:45:45 INFO - Cleaning up... 08:45:46 INFO - Return code: 0 08:45:46 INFO - Running post-action listener: _resource_record_post_action 08:45:46 INFO - Running post-action listener: _start_resource_monitoring 08:45:46 INFO - Starting resource monitoring. 08:45:46 INFO - ##### 08:45:46 INFO - ##### Running install step. 08:45:46 INFO - ##### 08:45:46 INFO - Running pre-action listener: _resource_record_pre_action 08:45:46 INFO - Running main action method: install 08:45:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:46 INFO - Reading from file tmpfile_stdout 08:45:46 INFO - Detecting whether we're running mozinstall >=1.0... 08:45:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:45:46 INFO - Reading from file tmpfile_stdout 08:45:46 INFO - Output received: 08:45:46 INFO - Usage: mozinstall [options] installer 08:45:46 INFO - Options: 08:45:46 INFO - -h, --help show this help message and exit 08:45:46 INFO - -d DEST, --destination=DEST 08:45:46 INFO - Directory to install application into. [default: 08:45:46 INFO - "/builds/slave/test"] 08:45:46 INFO - --app=APP Application being installed. [default: firefox] 08:45:46 INFO - mkdir: /builds/slave/test/build/application 08:45:46 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'] 08:45:46 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 08:46:02 INFO - Reading from file tmpfile_stdout 08:46:02 INFO - Output received: 08:46:02 INFO - /builds/slave/test/build/application/firefox/firefox 08:46:02 INFO - Running post-action listener: _resource_record_post_action 08:46:02 INFO - ##### 08:46:02 INFO - ##### Running run-tests step. 08:46:02 INFO - ##### 08:46:02 INFO - Running pre-action listener: _resource_record_pre_action 08:46:02 INFO - Running main action method: run_tests 08:46:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:46:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:46:02 INFO - Python 2.7.3 08:46:02 INFO - Return code: 0 08:46:02 INFO - grabbing minidump binary from tooltool 08:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:02 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 0x14a4410>, '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 0x14a5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a57a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:46:02 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 08:46:02 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 08:46:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:46:02 INFO - Return code: 0 08:46:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:46:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:46:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:46:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:46:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:46:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:46:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:46:03 INFO - Return code: 0 08:46:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:46:03 INFO - Using env: {'DISPLAY': ':0', 08:46:03 INFO - 'HOME': '/home/cltbld', 08:46:03 INFO - 'LANG': 'en_US.UTF-8', 08:46:03 INFO - 'LANGUAGE': 'en_US:en', 08:46:03 INFO - 'LOGNAME': 'cltbld', 08:46:03 INFO - 'MAIL': '/var/mail/cltbld', 08:46:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:46:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:03 INFO - 'MOZ_NO_REMOTE': '1', 08:46:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:03 INFO - 'NO_EM_RESTART': '1', 08:46:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:03 INFO - 'PWD': '/builds/slave/test', 08:46:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:46:03 INFO - 'SHELL': '/bin/bash', 08:46:03 INFO - 'SHLVL': '1', 08:46:03 INFO - 'TERM': 'linux', 08:46:03 INFO - 'TMOUT': '86400', 08:46:03 INFO - 'USER': 'cltbld', 08:46:03 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557', 08:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:03 INFO - '_': '/tools/buildbot/bin/python'} 08:46:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:46:04 INFO - mozversion application_buildid: 20160422053010 08:46:04 INFO - mozversion application_changeset: 4ca15e44f0b59c06d35b776320cb149e2422a2fc 08:46:04 INFO - mozversion application_display_name: Nightly 08:46:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:46:04 INFO - mozversion application_name: Firefox 08:46:04 INFO - mozversion application_remotingname: firefox 08:46:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:46:04 INFO - mozversion application_vendor: Mozilla 08:46:04 INFO - mozversion application_version: 48.0a1 08:46:04 INFO - mozversion platform_buildid: 20160422053010 08:46:04 INFO - mozversion platform_changeset: 4ca15e44f0b59c06d35b776320cb149e2422a2fc 08:46:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:46:04 INFO - mozversion platform_version: 48.0a1 08:46:04 INFO - using testdate: 1461339964 08:46:04 INFO - actual date: 1461339964 08:46:04 INFO - starting webserver on 'localhost:39370' 08:46:04 INFO - SUITE-START | Running 2 tests 08:46:04 INFO - TEST-START | dromaeo_css 08:46:04 INFO - operating with platform_type : linux_ 08:46:04 INFO - Initialising browser for dromaeo_css test... 08:46:04 INFO - TEST-INFO | started process 23109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2T5TBN/profile http://localhost:39370/getInfo.html) 08:46:07 INFO - PROCESS | 23109 | 08:46:07 INFO - PROCESS | 23109 | (process:23180): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:46:08 INFO - PROCESS | 23109 | __metrics Screen width/height:1600/1200 08:46:08 INFO - PROCESS | 23109 | colorDepth:24 08:46:08 INFO - PROCESS | 23109 | Browser inner width/height: 1024/697 08:46:08 INFO - PROCESS | 23109 | __metrics 08:46:09 ERROR - PROCESS | 23109 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:46:10 INFO - TEST-INFO | 23109: exit 0 08:46:10 INFO - Browser initialized. 08:46:10 INFO - Running cycle 1/1 for dromaeo_css test... 08:46:10 INFO - TEST-INFO | started process 23231 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2T5TBN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:11 INFO - PROCESS | 23231 | 08:46:11 INFO - PROCESS | 23231 | (process:23294): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:46:21 INFO - PROCESS | 23231 | RSS: Main: 163418112 08:46:21 INFO - PROCESS | 23231 | 08:47:11 INFO - PROCESS | 23231 | 1461340031533 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] 08:49:18 INFO - PROCESS | 23231 | Cycle 1(1): loaded http://localhost:39370/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39370/tests/dromaeo/cssquery-ext.html) 08:49:20 INFO - PROCESS | 23231 | RSS: Main: 169644032 08:49:20 INFO - PROCESS | 23231 | 08:52:22 INFO - PROCESS | 23231 | Cycle 1(1): loaded http://localhost:39370/tests/dromaeo/cssquery-ext.html (next: http://localhost:39370/tests/dromaeo/cssquery-jquery.html) 08:52:22 INFO - PROCESS | 23231 | RSS: Main: 166793216 08:52:22 INFO - PROCESS | 23231 | 08:55:24 INFO - PROCESS | 23231 | Cycle 1(1): loaded http://localhost:39370/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39370/tests/dromaeo/cssquery-mootools.html) 08:55:25 INFO - PROCESS | 23231 | RSS: Main: 167510016 08:55:25 INFO - PROCESS | 23231 | 08:58:26 INFO - PROCESS | 23231 | Cycle 1(1): loaded http://localhost:39370/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39370/tests/dromaeo/cssquery-prototype.html) 08:58:27 INFO - PROCESS | 23231 | RSS: Main: 165101568 08:58:27 INFO - PROCESS | 23231 | 09:01:29 INFO - PROCESS | 23231 | Cycle 1(1): loaded http://localhost:39370/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39370/tests/dromaeo/cssquery-yui.html) 09:01:30 INFO - PROCESS | 23231 | RSS: Main: 166338560 09:01:30 INFO - PROCESS | 23231 | 09:04:32 INFO - PROCESS | 23231 | Cycle 1(1): loaded http://localhost:39370/tests/dromaeo/cssquery-yui.html (next: http://localhost:39370/tests/dromaeo/cssquery-dojo.html) 09:04:33 INFO - PROCESS | 23231 | RSS: Main: 168361984 09:04:33 INFO - PROCESS | 23231 | 09:04:33 INFO - PROCESS | 23231 | __start_tp_report 09:04:33 INFO - PROCESS | 23231 | _x_x_mozilla_page_load 09:04:33 INFO - PROCESS | 23231 | _x_x_mozilla_page_load_details 09:04:33 INFO - PROCESS | 23231 | |i|pagename|runs| 09:04:33 INFO - PROCESS | 23231 | |0;dojo.html;3069.86185621647;3120.6411262704783;3133.529970504425;3160.6997335253145;3162.636296825866;5252.107141785896;5268.525832675058;5271.288376069229;5280.4983526564965;5301.469853014697;5261.552768014713;5264.657797243177;5286.259923610698;5366.570674346052;5377.677339359641;4758;4789.736564488951;4845.127876982142;4887.535684110004;4919.680220785655;4833;4958.281049247857;4964.875878103058;5004.224345226496;5005.449400565934;4768.73771942543;4801.687890287155;4849.490803465621;4899.338589290436;4905.4849240829735;4825.324454576362;4856.441509226449;4864.586510146642;4876.049170411771;4914.36113305268;4819.42166939966;4828.903421931542;4854.68444551103;4855.757212139414;4881.511848815126;5065.392152941634;5160.354955630546;5233.031889100491;5236.8690782730355;5241.764120614582;5564.610477266593;5600.915986260209;5614;5634.126710359901;5637.041702910515;5513.807016754395;5671.716414179275;5684.090545512699;5692.089265717506;5692.857678558028;5199.792008319662;5247.081760691902;5296.020236256267;5296.867578310535;5299.73501324936;5698.601097923189;5724.914126288109;5727.5131613812455;5739.569532285095;5750.4249575042995;5419.756110974937;5525.226468294442;5526.58550608706;5528.86177845549;5586.357568879631;5645.661260324394;5670.858228544319;5677.977963966526;5697.601167918288;5700.23046888673;5582.665040097607;5591.077472217039;5615.550755939515;5618.494335509824;5628.127640215773;5578.191162281447;5590.217369568264;5646.520045796071;5670.489655930986;5680.6307590007345;4235.830566777356;4258.254805409041;4261.680373971964;4263.8081286342185;4302.569743025672;3855.6722678572637;3858.421236814444;3869.5356557213313;3875.5349358076646;3880.3791393377487;5313.123334649817;5324.547413469821;5402.972985135128;5420.4759125980145;5468.562514998791;5689.601727879009;5734.799282025109;5739.454751798572;5747.281589801275;5794.449527294901;5440.591955603346;5448.918266225931;5449.918251226235;5453.563714902798;5456.399796022434;4800.903981920342;4880;4890.462049174588;4931.654784165145;4936.308916751657;5844.9415505845245;5862.179294898718;5869.442402971711;5878.735456904449;5934;5693.544516438675;5703.344115426779;5703.914441283301;5708.857278568069;5716.885662286814;5705.258316418839;5814.883702326015;5858.502027327725;5859.736311865891;5917.763289468373;5546.112621980464;5548.306461692288;5557.722113894209;5558.277423934863;5563.888722225452;5598.552115830806;5643.435656434323;5649.548036157015;5654.886902261849;5660.179274005164;5502.284702988586;5537.612367134262;5581.5255703265675;5587.776488940397;5632.127020311858;5418.783248670009;5543.667379957215;5548.861278468071;5578.135389014709;5605.32736071674;5409.7024663642305;5431.646942948696;5443.183522471661;5470.452954704498;5475.479829416199;5470.863228419322;5544.667319960815;5556.499915007668;5568.136938774496;5623.775048997994;5446.591505637014;5473.480019398151;5477.561795056466;5483.588730845282;5515.944840551543 09:04:33 INFO - PROCESS | 23231 | |1;ext.html;600.7807150390106;653.7744478155037;656.6552559906046;662.3442791636281;685.3626127701236;36411.81794091029;37532.81233593835;37593.62406375935;37753.62246377532;37767.24465510688;40277.194456110934;40536.189276214456;40582.59417405825;40843.38734918978;41086.17827643445;8410.537420441888;8513.063563008096;8541.103184165666;8579.099194584573;8595.054544000155;8471.830563388728;8530.957345213264;8547.615357308905;8548.74353769388;8601.268892144175;8607.225349718525;8657.26413254874;8674.826503469927;8682.479051256912;8685.652573897036;8545.914540854574;8547.700830470903;8569.957150214272;8582.613782379807;8597.699080532151;8476.957615211884;8501.277391421736;8538.786530336729;8561.700340488116;8579.957100214458;31217.531737023965;37533.24933501315;37926.43110353347;37967.81016094902;38040.42939355884;2944.322805754667;3079.5842561254167;3142.3872344892757;3272.541844141822;3342.181165614416;28101.718982810115;28253;28386.29034274139;28918;29436;3789.4315852622053;3931.2923673738715;3936.8228429720443;3989.920201595981;4002.679785617144;255114;259722;259835;260299;260763;35115;36185.276294473966;57550;57930;58375;33849.32301353959;33937.64249429995;34031.14922126967;34046.14884627855;34216.14459638529;15516.689666206612;15742.9212853935;15752.92123539375;15799.447019354267;15813.762793558106;13376.598702038955;13419.396127174301;13422.328883555783;13441.126326788728;13504.864951350557;8439.95780021096;8502.872456913152;8520.360972927056;8573.828523429496;8617.35369847264;3212.1969507623094;3225.3549290142064;3248.6751324867796;3270.787398819069;3281.753868459875;1088.613542192526;1126.3467189030343;1137.5536640444666;1138.6470194239812;1143.5482984221353;30137.246568835515;30576.69423305783;31854;31902.361952760813;31990;1171.7832201042834;1173.0146676791537;1183.5147589488267;1233.9814902776466;1301.8763217494322;16346.75479867803;16775.412860550066;16796.664066718597;16851.57871053209;17255.56861078483;214780;216698;218516;218747;461916;56605.15092273619;57357;57471;57511.42488575061;57551.424485755444;1339.8928085753116;1381.5924302330836;1404.2978510744629;1404.7611905975805;1420.4460260498413;29063.273418164714;30388.24029399283;30621.54067689031;31051;31141.532877007317;51361.22958155556;51674.74162629163;51774;51828.481715182366;52048;390420;390820;392158;392882;395290;28319.2920176989;28555.28611784722;28643.713562864104;28978.855105724335;29030.12909612715;47308;47720.2841957364;47966.406718657105;48488;48511.75744121257;39582;39859.202815944096;40281;40597.39103913384;41168.38247426351;39027;40910;41318.1736365277;41681.79159104185;41772;35979.10052248715;42222.57777422186;42295;43264;43399.34900976551;31131.84434077906;31525.684743152276;33334;34066.82966585151;34255.82872085624;26569.867150664122;27249.72750272472;27598.44803103967;28025.29936751516;28115.297117572223 09:04:33 INFO - PROCESS | 23231 | |2;jquery.html;379.9677027452667;381.6793893129772;391.59469948603197;393.38042582931854;395.1405692618554;13884.652883677913;16891;17146.31414743409;19013.429597112092;19197;17897.46307610774;17964;18271.451856444328;18289.634207315845;18873.339433119843;5311.49540793625;5489.560835133179;5494.066008778497;5517.944820551783;5539.473749993744;5514.889702205954;5554.583406244527;5720.599558030939;5721.34204566476;5727.198192253088;5639.436056394348;5653.547716182716;5656.519195868356;5660.009498337795;5663.631863928852;5442.591805614575;5664.490195882349;5667.716614169275;5667.971660141693;5668.206451096849;4877.268409738532;5011.3485246918035;5018.146915024418;5033.647644664875;5039;16936.40722574704;22179;22378.552428951494;22455;22596.548069038527;2327.394877331889;2590.7020692620404;2606.478704259137;2805.7615102716295;3118.8128712277335;13915.930420347935;14034.508792192326;14156.150630962175;14233.928830355782;14398.352074156688;1783.3401641392768;1862.1527205121638;1881.595456976743;1920.4526709887614;1924.4611508777564;74171.62914185449;74581.25418745851;74992.25007749908;75439;76256;9991;10060.993900610027;10216.284860059874;10456.64063671733;10522.526486308134;14254;14310.928445357707;14322.856771432153;14366.35351409189;14377.856221437862;8104.797380065427;8170.101288858221;8214.83570328602;8335.249827515552;8413.915860841313;8218.947784810032;8298.170182981654;8298.626561804733;8386.496810191285;8441.746747597583;6332.908417320668;6363.713632886439;6373.458256048288;6439.774607888701;6450.612963222222;1794.6949018666858;1809.4481183239238;1816.954576135607;1841.3831366492375;1846.2430403534486;1022.0392830739081;1039.1323245090282;1084.7450849050467;1102.3000394749392;1104.5913012185542;18915.527111822314;19104.904475477535;19284.421467356;19391.3213037543;19783;1055.1822337688352;1080.9567617295377;1092.4865313302735;1103.862017247844;1124.3591153042687;10972.396518191417;11326.207165498336;11336.263142895685;11412.885871141183;11425.942870285762;454817;463078;488789;490286;490348;77086;77907;78650.60674696704;78765.60617196992;79492.6025369881;1077.7952189084049;1091.1543553745753;1094.0864378244096;1094.4691824465128;1107.4075369677184;17060.493382911478;17094.230759616097;17209.225584848962;17209.483715488554;17351.739723904404;36404.63595364012;36607;36920.26159476849;37124;37715.81142094272;46065.53934460747;54386.728066359414;58153.418465816496;59454.405455944885;60322.09516857163;5578.721063946705;7667.463277570517;7938.285554300141;8195.67217311301;8503;13163;13376;13406.530771422953;13474.124181928144;13495.392707327997;11389.943050284695;11588.420578971187;11606.30362178272;11681;11954.58158964432;11103.888961110608;11353.262037967506;11357.54569817198;11611.709707257387;11685.591004314809;11544.538218471167;11698.532058717556;11907.642770716893;11917.76164476723;12046.698832529257;8078.111407745261;8115.229053239933;8128.9593552031865;8162.061362943337;8638;9872.605095796087;11447.198696091195;11753.764924701629;11822.881771182178;12039 09:04:33 INFO - PROCESS | 23231 | |3;mootools.html;1469.2506821521022;1491.1500444746491;1640.983590164098;1748.1346733366986;1785.9017754023523;6726.562773419724;7703.961480192598;7766;7875.527468351903;7884.881726774103;7860.292573668368;7864.528128312305;7922;7922.881156782653;7937.642806073726;2198.428408613764;2220.7779222077825;2221.300290408516;2221.80003799658;2229.8662080275235;2167.9783202167932;2173.1633321171385;2184;2211.8783466909313;2212.590670725913;2146.302451703195;2169.4359466538735;2174.239016344283;2174.4781252499365;2185.945351366213;2146.3131797824703;2158.579077079962;2161.8919054047315;2164.426426996847;2167.4473009382664;2129.5634394948997;2138.8716676999275;2142.7107340508987;2143.9892800536054;2151.214806595597;7976.840463190703;8025.357971362277;8035.517868927883;8044.517328960223;8044.919550804534;4805.135075686375;4925.876853078702;4988.575971042465;5013.04752097104;5015.448300686921;3232.337370838972;3247.7888937219004;3254.1376535218187;3265.9183520411943;3271.06774569249;1077.13828936851;1090.1442367741286;1124.7694222684331;1129.4917287220783;1983.9008049597608;10552.419616921066;10570.365778053265;10575.312604680672;10622.36265824053;10629.893701063045;4114.691398145151;4218.810153543098;4380.6933514653665;4402.449693788277;4410.117976404732;8380.371472139492;8391;8401.327893768485;8457.323414126855;8481.787955301043;4797.664163508591;4802.943352462453;4823.445303790038;4849.466558678542;4857.927131093036;3899.395593682984;4503.437070366204;4508.797104130322;4518.277075667877;4565.885852853638;3607.783532988029;3639.1993761372987;3704.759190652599;3717.275131349361;3724.944125838115;1104.7900898829196;1121.097516499226;1125.5722825326488;1128.1313388690662;1128.700894263021;804.6137853830078;896.2068569316202;934.4860326820221;936.6440752514001;962.7352478068448;5319.521243088141;5338.626296159309;5358.785648574091;5400.351957765093;5404.054290499147;400.46737838675074;405.6815399911056;417.6825612534435;418.5563302898937;418.82200064972267;3619.3666108431444;3737.4580685800406;3749.2126653402547;3762.9059273518383;3791.3175628386603;9377.578008989612;9888.406695598287;9916.553755081039;9950.850737238947;9982.101610855058;9713.90286097144;9803.852942205873;9807;9810.21518278536;9830.361026533252;7259.637018149071;7472.402207823361;7492.850142997109;7552.207018263113;7674.57789821554;5257.763400647056;5342.732863356894;5402.108652072364;5454.509094181542;5521.751521181476;8392.244697977212;8399.244068033662;8438;8503;8621.784455388666;8304.667813287642;8838.955805220932;9099.317551183556;9179.632814687338;9184.21934135606;6363.331850155667;6874.862502749817;7037.225905150532;7329.157146927958;7626;7832.255935686101;7844.137144913941;7856.25365590268;7883.881741773993;7913.762587122395;6730.394264516021;6870.038194652852;6969.58182509051;7147.53541019832;7200.675969581486;7037.1555413350725;7118.181409137808;7150.606716630636;7189.209186989322;7189.964050179716;6087.9391206087375;6305.4009869062365;6315.936840631535;6411.198600174978;6542.5747326425535;4762.095201911626;4849.369581954324;4864.124457597525;4888.755562221946;4971.627127965345;4853.174960256835;4899.387576552931;4939;4982.153033984304;5042.520960508746 09:04:33 INFO - PROCESS | 23231 | |4;prototype.html;320.77705994333945;323.69734298430967;331.1423413359399;332.10000897567585;337.6033161035782;5874.206982057421;5991.850203744903;5992.932438308782;5997.31030931443;6114.266288045435;5976.760929562813;6005.3394126646035;6029.366916473773;6039.5168386529085;6044.969775151129;4585.79363928624;4606.608438282741;4607.838725644603;4614.792334344946;4625.398698169233;4477.6417886569;4620.353150558924;4633.443986721598;4636;4637.536246375353;4561.543845615445;4583.862484125481;4587.42657167854;4598.82729903874;4616.6306695464455;4552.863414097583;4583.472900616405;4591.701539399928;4602.792874320664;4610.354550362918;3687.8524859005875;3885.941710874339;3901.317269477858;4045.3122969095325;4058.959410405888;5743.339515955677;5781.624194427391;5799.623024503394;5799.8550036249435;5800.100984347433;5194.182036287307;5198.6880787152895;5207.973960130175;5209.400918894337;5226.660267082665;5938.257717785277;6245.156903817971;6321;6321.0834429008;6327.114204011442;4298.935515967263;4300;4310.224159651261;4318.935215971763;4319.784010799447;6269.868244796837;6514.5114116441455;6565.54041217115;6581.111549940744;6585.078089067534;4348.130373925228;4350.086481838786;4352.69531132824;4390.407295015132;4396.3625274335045;4380.123975204971;4404.955950440519;4406.62543683784;4409.470863496337;4419.64642828573;5050.141475949024;5142.51146141116;5182.067227898939;5184.662996905189;5209.6353255272525;6128.111423843607;6357.618542887441;6383.489081005521;6390.265119511316;6392.296847346788;1507.3367718203956;1527.9159646219564;1529.4417537598697;1532.6934613077206;1544.6138465383654;1005.0903931941605;1018.4703953944056;1026.3585259212991;1028.136365453008;1045.9372437653765;6059.48494377974;6093.146959425684;6101.206843110456;6122.632642041492;6136.969315153396;6419.679016049179;6480.351964803482;6495.863223935792;6504.089427480157;6532.346765323429;5947.345791962881;6080.9391906081255;6134.294556126102;6137.9182843408635;6144.385561443909;3483.9444727610326;3499.5975462822103;3510.754247202671;3513.4905438711244;3522.5244591980268;6521.380468855451;6709.496787740939;6734;6740.12378390806;6749.730010799612;6615.470762339001;6623.43700785429;6631.966840165768;6642.63465509392;6654.26803051664;6578.967105164444;6701.229358623723;6734.393904548614;6752.088468056848;6754.662266886734;6466.935330646822;6498.642574658439;6508.772192973223;6524.217093948567;6527.771527996498;6261.869065467266;6410.839729006812;6418.935810641834;6440.710168042543;6443.323451037573;6650.866982660223;6671.566348187353;6682.064510968371;6692.694924489872;6698.966505167443;4317.546657600907;4359.673024523237;4373.453318335208;4377.759223242625;4404.1411924674385;6262.029385445263;6284.277308109626;6431.941778630793;6442.484601231797;6474.935250647622;6377.266614339224;6380.649064301508;6385.616862988236;6406.23125224976;6414.005829096497;6254.466940888948;6386.978083506617;6390.169277993831;6392.488600911823;6424.357564243538;6180.443760061616;6206.813795586139;6214.347493513116;6214.564980451506;6275.309715931153;6337.7148028337915;6406.711697973509;6407.519436042222;6446.935530644633;6463.450606698295;5981.162637230878;6218.782342617987;6308.495320374267;6327.873442531216;6376.171097757262 09:04:33 INFO - PROCESS | 23231 | |5;yui.html;819.1562690428858;824.2375802382791;824.6866190847477;847.3179090831878;848.5375470368652;12519.499220031199;12689.809652855214;12705.491780328775;12718.1733187343;12825.358732063394;10445.84331235032;12665.303408312539;12738.872611273884;12741.490340386397;12741.554045608405;788.388998526144;810.4934415990007;816.7141500474846;816.8693009118542;817.0726225733775;801.3348920396057;803.6263137640996;804.6459557794581;804.8712206047034;807.8909347238135;842.540815255684;842.970496032639;844.9704260350888;845.2392846438194;848.9023762267326;834.7287131682198;841.0538144587339;841.2260720137489;842.7429633961639;843.1020962674731;612.0268772651506;615.4430240632234;617.4473845907933;618.6380967134232;620.3455354600894;13257.403416846266;13293;13296.800547991692;13298.867011329956;13310.401031953585;12782.488700451971;12800.295983720891;13164.473421063147;13307.733845323039;13324.400401981935;11981.580644677482;11983.340916249603;12093.153479256456;12143.696407589792;12249.265044097383;4281.357796330544;4291.4850217973735;4382.364557139229;4412.249917513998;4418.204723149832;52168;54949.901001980135;56559.151612725844;56833.43166568364;56855;10498.790024199627;11045.558177672963;11258.43707814606;11283.60507382254;11316.6039188628;18545.53636159107;18646.906765466087;18736.344227951955;18803;18894.905525472284;7804.2195780422635;7813.453058285865;8270.37972152079;8283.25450709439;8378.539180345018;4338.284183109751;4513.526079761644;4515.954840451619;4571.611413029863;4702.482726900038;3062.632484101922;3118.0334096429724;3120.547520609499;3138.9686103138674;3139.8116113033293;567.2172402085179;571.0777094991558;571.3030103273999;593.9495142912814;622.4211483320465;644.255884453457;691.6126968897433;740.9962950185322;752.3266676324658;755.4296506137831;7977.282044615897;8637.385654653432;8746;8862;8883.822323553493;659.7954634063456;714.6676795290111;750.936170425509;752.665064046505;753.898223739799;4173;4302.913941721211;4317.891118394751;4333.306670932636;4347.717398369159;69030;69846;70714.64642676753;71660.64169679118;71935.64032179806;59395.703021484616;59716.70141649264;61102.38897610967;61918;62104.06843897345;54332;54785.45214547803;54981;55987.16019259714;56546.71726641423;8209.302209312036;8344.541050242295;8361.247487726134;8452.154784521745;8515.616797244264;31566;31753.8412307937;32641;33411.49882751712;36194;44276.33585496156;44772.32841507315;44924.326135108655;44937.550624494645;45261.868453287614;11152.884711528783;11239.438028098399;11550.768984620428;11750.471228794553;11953.103517236068;11599.304041757521;11724.70688232801;11834.349110798988;11859.525618975144;12717.109802314118;11447.084233261152;11865;11872.347020913587;11885.643430697093;12910.289934053717;11982.940085299866;12062.819057714318;12080.21478603888;12182.878171218174;12639.873601264237;12274.263544187377;12424.689382765504;12485.812712809133;12573.49706011786;12655.746885062432;9582.329236953346;9703.66037188695;9886.604535818775;9891.950540247253;10210;9660.855087173557;9795.16741076988;9828;9838.016198380104;9913.45475998827 09:04:33 INFO - PROCESS | 23231 | __end_tp_report 09:04:33 INFO - PROCESS | 23231 | __start_cc_report 09:04:33 INFO - PROCESS | 23231 | _x_x_mozilla_cycle_collect,342 09:04:33 INFO - PROCESS | 23231 | __end_cc_report 09:04:33 INFO - PROCESS | 23231 | __startTimestamp1461341073103__endTimestamp 09:04:33 INFO - PROCESS | 23231 | 09:04:33 INFO - PROCESS | 23231 | ------- Summary: start ------- 09:04:33 INFO - PROCESS | 23231 | Number of tests: 6 09:04:33 INFO - PROCESS | 23231 | 09:04:33 INFO - PROCESS | 23231 | [#0] dojo.html Cycles:165 Average:5264.95 Median:5470.86 stddev:584.26 (10.7%) stddev-sans-first:560.10 09:04:33 INFO - PROCESS | 23231 | Values: 3069.9 3120.6 3133.5 3160.7 3162.6 5252.1 5268.5 5271.3 5280.5 5301.5 5261.6 5264.7 5286.3 5366.6 5377.7 4758.0 4789.7 4845.1 4887.5 4919.7 4833.0 4958.3 4964.9 5004.2 5005.4 4768.7 4801.7 4849.5 4899.3 4905.5 4825.3 4856.4 4864.6 4876.0 4914.4 4819.4 4828.9 4854.7 4855.8 4881.5 5065.4 5160.4 5233.0 5236.9 5241.8 5564.6 5600.9 5614.0 5634.1 5637.0 5513.8 5671.7 5684.1 5692.1 5692.9 5199.8 5247.1 5296.0 5296.9 5299.7 5698.6 5724.9 5727.5 5739.6 5750.4 5419.8 5525.2 5526.6 5528.9 5586.4 5645.7 5670.9 5678.0 5697.6 5700.2 5582.7 5591.1 5615.6 5618.5 5628.1 5578.2 5590.2 5646.5 5670.5 5680.6 4235.8 4258.3 4261.7 4263.8 4302.6 3855.7 3858.4 3869.5 3875.5 3880.4 5313.1 5324.5 5403.0 5420.5 5468.6 5689.6 5734.8 5739.5 5747.3 5794.4 5440.6 5448.9 5449.9 5453.6 5456.4 4800.9 4880.0 4890.5 4931.7 4936.3 5844.9 5862.2 5869.4 5878.7 5934.0 5693.5 5703.3 5703.9 5708.9 5716.9 5705.3 5814.9 5858.5 5859.7 5917.8 5546.1 5548.3 5557.7 5558.3 5563.9 5598.6 5643.4 5649.5 5654.9 5660.2 5502.3 5537.6 5581.5 5587.8 5632.1 5418.8 5543.7 5548.9 5578.1 5605.3 5409.7 5431.6 5443.2 5470.5 5475.5 5470.9 5544.7 5556.5 5568.1 5623.8 5446.6 5473.5 5477.6 5483.6 5515.9 09:04:33 INFO - PROCESS | 23231 | 09:04:33 INFO - PROCESS | 23231 | [#1] ext.html Cycles:180 Average:46845.66 Median:37563.44 stddev:83637.63 (222.7%) stddev-sans-first:83800.18 09:04:33 INFO - PROCESS | 23231 | Values: 600.8 653.8 656.7 662.3 685.4 36411.8 37532.8 37593.6 37753.6 37767.2 40277.2 40536.2 40582.6 40843.4 41086.2 8410.5 8513.1 8541.1 8579.1 8595.1 8471.8 8531.0 8547.6 8548.7 8601.3 8607.2 8657.3 8674.8 8682.5 8685.7 8545.9 8547.7 8570.0 8582.6 8597.7 8477.0 8501.3 8538.8 8561.7 8580.0 31217.5 37533.2 37926.4 37967.8 38040.4 2944.3 3079.6 3142.4 3272.5 3342.2 28101.7 28253.0 28386.3 28918.0 29436.0 3789.4 3931.3 3936.8 3989.9 4002.7 255114.0 259722.0 259835.0 260299.0 260763.0 35115.0 36185.3 57550.0 57930.0 58375.0 33849.3 33937.6 34031.1 34046.1 34216.1 15516.7 15742.9 15752.9 15799.4 15813.8 13376.6 13419.4 13422.3 13441.1 13504.9 8440.0 8502.9 8520.4 8573.8 8617.4 3212.2 3225.4 3248.7 3270.8 3281.8 1088.6 1126.3 1137.6 1138.6 1143.5 30137.2 30576.7 31854.0 31902.4 31990.0 1171.8 1173.0 1183.5 1234.0 1301.9 16346.8 16775.4 16796.7 16851.6 17255.6 214780.0 216698.0 218516.0 218747.0 461916.0 56605.2 57357.0 57471.0 57511.4 57551.4 1339.9 1381.6 1404.3 1404.8 1420.4 29063.3 30388.2 30621.5 31051.0 31141.5 51361.2 51674.7 51774.0 51828.5 52048.0 390420.0 390820.0 392158.0 392882.0 395290.0 28319.3 28555.3 28643.7 28978.9 29030.1 47308.0 47720.3 47966.4 48488.0 48511.8 39582.0 39859.2 40281.0 40597.4 41168.4 39027.0 40910.0 41318.2 41681.8 41772.0 35979.1 42222.6 42295.0 43264.0 43399.3 31131.8 31525.7 33334.0 34066.8 34255.8 26569.9 27249.7 27598.4 28025.3 28115.3 09:04:33 INFO - PROCESS | 23231 | 09:04:33 INFO - PROCESS | 23231 | [#2] jquery.html Cycles:180 Average:27852.95 Median:22416.78 stddev:78416.83 (349.8%) stddev-sans-first:78609.68 09:04:33 INFO - PROCESS | 23231 | Values: 380.0 381.7 391.6 393.4 395.1 13884.7 16891.0 17146.3 19013.4 19197.0 17897.5 17964.0 18271.5 18289.6 18873.3 5311.5 5489.6 5494.1 5517.9 5539.5 5514.9 5554.6 5720.6 5721.3 5727.2 5639.4 5653.5 5656.5 5660.0 5663.6 5442.6 5664.5 5667.7 5668.0 5668.2 4877.3 5011.3 5018.1 5033.6 5039.0 16936.4 22179.0 22378.6 22455.0 22596.5 2327.4 2590.7 2606.5 2805.8 3118.8 13915.9 14034.5 14156.2 14233.9 14398.4 1783.3 1862.2 1881.6 1920.5 1924.5 74171.6 74581.3 74992.3 75439.0 76256.0 9991.0 10061.0 10216.3 10456.6 10522.5 14254.0 14310.9 14322.9 14366.4 14377.9 8104.8 8170.1 8214.8 8335.2 8413.9 8218.9 8298.2 8298.6 8386.5 8441.7 6332.9 6363.7 6373.5 6439.8 6450.6 1794.7 1809.4 1817.0 1841.4 1846.2 1022.0 1039.1 1084.7 1102.3 1104.6 18915.5 19104.9 19284.4 19391.3 19783.0 1055.2 1081.0 1092.5 1103.9 1124.4 10972.4 11326.2 11336.3 11412.9 11425.9 454817.0 463078.0 488789.0 490286.0 490348.0 77086.0 77907.0 78650.6 78765.6 79492.6 1077.8 1091.2 1094.1 1094.5 1107.4 17060.5 17094.2 17209.2 17209.5 17351.7 36404.6 36607.0 36920.3 37124.0 37715.8 46065.5 54386.7 58153.4 59454.4 60322.1 5578.7 7667.5 7938.3 8195.7 8503.0 13163.0 13376.0 13406.5 13474.1 13495.4 11389.9 11588.4 11606.3 11681.0 11954.6 11103.9 11353.3 11357.5 11611.7 11685.6 11544.5 11698.5 11907.6 11917.8 12046.7 8078.1 8115.2 8129.0 8162.1 8638.0 9872.6 11447.2 11753.8 11822.9 12039.0 09:04:33 INFO - PROCESS | 23231 | 09:04:33 INFO - PROCESS | 23231 | [#3] mootools.html Cycles:180 Average:5231.65 Median:4985.36 stddev:2866.93 (57.5%) stddev-sans-first:2861.03 09:04:33 INFO - PROCESS | 23231 | Values: 1469.3 1491.2 1641.0 1748.1 1785.9 6726.6 7704.0 7766.0 7875.5 7884.9 7860.3 7864.5 7922.0 7922.9 7937.6 2198.4 2220.8 2221.3 2221.8 2229.9 2168.0 2173.2 2184.0 2211.9 2212.6 2146.3 2169.4 2174.2 2174.5 2185.9 2146.3 2158.6 2161.9 2164.4 2167.4 2129.6 2138.9 2142.7 2144.0 2151.2 7976.8 8025.4 8035.5 8044.5 8044.9 4805.1 4925.9 4988.6 5013.0 5015.4 3232.3 3247.8 3254.1 3265.9 3271.1 1077.1 1090.1 1124.8 1129.5 1983.9 10552.4 10570.4 10575.3 10622.4 10629.9 4114.7 4218.8 4380.7 4402.4 4410.1 8380.4 8391.0 8401.3 8457.3 8481.8 4797.7 4802.9 4823.4 4849.5 4857.9 3899.4 4503.4 4508.8 4518.3 4565.9 3607.8 3639.2 3704.8 3717.3 3724.9 1104.8 1121.1 1125.6 1128.1 1128.7 804.6 896.2 934.5 936.6 962.7 5319.5 5338.6 5358.8 5400.4 5404.1 400.5 405.7 417.7 418.6 418.8 3619.4 3737.5 3749.2 3762.9 3791.3 9377.6 9888.4 9916.6 9950.9 9982.1 9713.9 9803.9 9807.0 9810.2 9830.4 7259.6 7472.4 7492.9 7552.2 7674.6 5257.8 5342.7 5402.1 5454.5 5521.8 8392.2 8399.2 8438.0 8503.0 8621.8 8304.7 8839.0 9099.3 9179.6 9184.2 6363.3 6874.9 7037.2 7329.2 7626.0 7832.3 7844.1 7856.3 7883.9 7913.8 6730.4 6870.0 6969.6 7147.5 7200.7 7037.2 7118.2 7150.6 7189.2 7190.0 6087.9 6305.4 6315.9 6411.2 6542.6 4762.1 4849.4 4864.1 4888.8 4971.6 4853.2 4899.4 4939.0 4982.2 5042.5 09:04:33 INFO - PROCESS | 23231 | 09:04:33 INFO - PROCESS | 23231 | [#4] prototype.html Cycles:180 Average:5268.44 Median:6042.24 stddev:1602.89 (26.5%) stddev-sans-first:1563.78 09:04:33 INFO - PROCESS | 23231 | Values: 320.8 323.7 331.1 332.1 337.6 5874.2 5991.9 5992.9 5997.3 6114.3 5976.8 6005.3 6029.4 6039.5 6045.0 4585.8 4606.6 4607.8 4614.8 4625.4 4477.6 4620.4 4633.4 4636.0 4637.5 4561.5 4583.9 4587.4 4598.8 4616.6 4552.9 4583.5 4591.7 4602.8 4610.4 3687.9 3885.9 3901.3 4045.3 4059.0 5743.3 5781.6 5799.6 5799.9 5800.1 5194.2 5198.7 5208.0 5209.4 5226.7 5938.3 6245.2 6321.0 6321.1 6327.1 4298.9 4300.0 4310.2 4318.9 4319.8 6269.9 6514.5 6565.5 6581.1 6585.1 4348.1 4350.1 4352.7 4390.4 4396.4 4380.1 4405.0 4406.6 4409.5 4419.6 5050.1 5142.5 5182.1 5184.7 5209.6 6128.1 6357.6 6383.5 6390.3 6392.3 1507.3 1527.9 1529.4 1532.7 1544.6 1005.1 1018.5 1026.4 1028.1 1045.9 6059.5 6093.1 6101.2 6122.6 6137.0 6419.7 6480.4 6495.9 6504.1 6532.3 5947.3 6080.9 6134.3 6137.9 6144.4 3483.9 3499.6 3510.8 3513.5 3522.5 6521.4 6709.5 6734.0 6740.1 6749.7 6615.5 6623.4 6632.0 6642.6 6654.3 6579.0 6701.2 6734.4 6752.1 6754.7 6466.9 6498.6 6508.8 6524.2 6527.8 6261.9 6410.8 6418.9 6440.7 6443.3 6650.9 6671.6 6682.1 6692.7 6699.0 4317.5 4359.7 4373.5 4377.8 4404.1 6262.0 6284.3 6431.9 6442.5 6474.9 6377.3 6380.6 6385.6 6406.2 6414.0 6254.5 6387.0 6390.2 6392.5 6424.4 6180.4 6206.8 6214.3 6214.6 6275.3 6337.7 6406.7 6407.5 6446.9 6463.5 5981.2 6218.8 6308.5 6327.9 6376.2 09:04:33 INFO - PROCESS | 23231 | 09:04:33 INFO - PROCESS | 23231 | [#5] yui.html Cycles:180 Average:15040.08 Median:28435.24 stddev:18523.58 (65.1%) stddev-sans-first:18544.76 09:04:33 INFO - PROCESS | 23231 | Values: 819.2 824.2 824.7 847.3 848.5 12519.5 12689.8 12705.5 12718.2 12825.4 10445.8 12665.3 12738.9 12741.5 12741.6 788.4 810.5 816.7 816.9 817.1 801.3 803.6 804.6 804.9 807.9 842.5 843.0 845.0 845.2 848.9 834.7 841.1 841.2 842.7 843.1 612.0 615.4 617.4 618.6 620.3 13257.4 13293.0 13296.8 13298.9 13310.4 12782.5 12800.3 13164.5 13307.7 13324.4 11981.6 11983.3 12093.2 12143.7 12249.3 4281.4 4291.5 4382.4 4412.2 4418.2 52168.0 54949.9 56559.2 56833.4 56855.0 10498.8 11045.6 11258.4 11283.6 11316.6 18545.5 18646.9 18736.3 18803.0 18894.9 7804.2 7813.5 8270.4 8283.3 8378.5 4338.3 4513.5 4516.0 4571.6 4702.5 3062.6 3118.0 3120.5 3139.0 3139.8 567.2 571.1 571.3 593.9 622.4 644.3 691.6 741.0 752.3 755.4 7977.3 8637.4 8746.0 8862.0 8883.8 659.8 714.7 750.9 752.7 753.9 4173.0 4302.9 4317.9 4333.3 4347.7 69030.0 69846.0 70714.6 71660.6 71935.6 59395.7 59716.7 61102.4 61918.0 62104.1 54332.0 54785.5 54981.0 55987.2 56546.7 8209.3 8344.5 8361.2 8452.2 8515.6 31566.0 31753.8 32641.0 33411.5 36194.0 44276.3 44772.3 44924.3 44937.6 45261.9 11152.9 11239.4 11550.8 11750.5 11953.1 11599.3 11724.7 11834.3 11859.5 12717.1 11447.1 11865.0 11872.3 11885.6 12910.3 11982.9 12062.8 12080.2 12182.9 12639.9 12274.3 12424.7 12485.8 12573.5 12655.7 9582.3 9703.7 9886.6 9892.0 10210.0 9660.9 9795.2 9828.0 9838.0 9913.5 09:04:33 INFO - PROCESS | 23231 | -------- Summary: end -------- 09:04:33 INFO - PROCESS | 23231 | 09:04:33 INFO - TEST-INFO | 23231: exit 0 09:04:33 INFO - TEST-OK | dromaeo_css | took 1109607ms 09:04:33 INFO - TEST-START | kraken 09:04:33 INFO - operating with platform_type : linux_ 09:04:33 INFO - Initialising browser for kraken test... 09:04:33 INFO - TEST-INFO | started process 23466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHF5Jio/profile http://localhost:39370/getInfo.html) 09:04:37 INFO - PROCESS | 23466 | 09:04:37 INFO - PROCESS | 23466 | (process:23531): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:04:38 INFO - PROCESS | 23466 | __metrics Screen width/height:1600/1200 09:04:38 INFO - PROCESS | 23466 | colorDepth:24 09:04:38 INFO - PROCESS | 23466 | Browser inner width/height: 1024/697 09:04:38 INFO - PROCESS | 23466 | __metrics 09:04:38 ERROR - PROCESS | 23466 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:04:39 INFO - TEST-INFO | 23466: exit 0 09:04:39 INFO - Browser initialized. 09:04:39 INFO - Running cycle 1/1 for kraken test... 09:04:39 INFO - TEST-INFO | started process 23582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHF5Jio/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:41 INFO - PROCESS | 23582 | 09:04:41 INFO - PROCESS | 23582 | (process:23643): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:04:51 INFO - PROCESS | 23582 | RSS: Main: 164425728 09:04:51 INFO - PROCESS | 23582 | 09:04:53 INFO - PROCESS | 23582 | Cycle 1(1): loaded http://localhost:39370/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39370/tests/kraken/driver.html?testName=audio-beat-detection) 09:04:54 INFO - PROCESS | 23582 | RSS: Main: 168898560 09:04:54 INFO - PROCESS | 23582 | 09:04:57 INFO - PROCESS | 23582 | Cycle 1(1): loaded http://localhost:39370/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39370/tests/kraken/driver.html?testName=audio-dft) 09:04:58 INFO - PROCESS | 23582 | RSS: Main: 172699648 09:04:58 INFO - PROCESS | 23582 | 09:05:00 INFO - PROCESS | 23582 | Cycle 1(1): loaded http://localhost:39370/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39370/tests/kraken/driver.html?testName=audio-fft) 09:05:01 INFO - PROCESS | 23582 | RSS: Main: 164638720 09:05:01 INFO - PROCESS | 23582 | 09:05:03 INFO - PROCESS | 23582 | Cycle 1(1): loaded http://localhost:39370/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39370/tests/kraken/driver.html?testName=audio-oscillator) 09:05:04 INFO - PROCESS | 23582 | RSS: Main: 165502976 09:05:04 INFO - PROCESS | 23582 | 09:05:06 INFO - PROCESS | 23582 | Cycle 1(1): loaded http://localhost:39370/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39370/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:05:07 INFO - PROCESS | 23582 | RSS: Main: 165384192 09:05:07 INFO - PROCESS | 23582 | 09:05:10 INFO - PROCESS | 23582 | Cycle 1(1): loaded http://localhost:39370/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39370/tests/kraken/driver.html?testName=imaging-darkroom) 09:05:10 INFO - PROCESS | 23582 | RSS: Main: 165990400 09:05:10 INFO - PROCESS | 23582 | 09:05:14 INFO - PROCESS | 23582 | Cycle 1(1): loaded http://localhost:39370/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39370/tests/kraken/driver.html?testName=imaging-desaturate) 09:05:14 INFO - PROCESS | 23582 | RSS: Main: 165974016 09:05:14 INFO - PROCESS | 23582 | 09:05:17 INFO - PROCESS | 23582 | Cycle 1(1): loaded http://localhost:39370/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39370/tests/kraken/driver.html?testName=json-parse-financial) 09:05:18 INFO - PROCESS | 23582 | RSS: Main: 166354944 09:05:18 INFO - PROCESS | 23582 | 09:05:20 INFO - PROCESS | 23582 | Cycle 1(1): loaded http://localhost:39370/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39370/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:05:20 INFO - PROCESS | 23582 | RSS: Main: 165888000 09:05:20 INFO - PROCESS | 23582 | 09:05:22 INFO - PROCESS | 23582 | Cycle 1(1): loaded http://localhost:39370/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39370/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:05:23 INFO - PROCESS | 23582 | RSS: Main: 165703680 09:05:23 INFO - PROCESS | 23582 | 09:05:25 INFO - PROCESS | 23582 | Cycle 1(1): loaded http://localhost:39370/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39370/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:05:25 INFO - PROCESS | 23582 | RSS: Main: 166281216 09:05:25 INFO - PROCESS | 23582 | 09:05:28 INFO - PROCESS | 23582 | Cycle 1(1): loaded http://localhost:39370/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:05:29 INFO - PROCESS | 23582 | RSS: Main: 166715392 09:05:29 INFO - PROCESS | 23582 | 09:05:31 INFO - PROCESS | 23582 | Cycle 1(1): loaded http://localhost:39370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:05:32 INFO - PROCESS | 23582 | RSS: Main: 166694912 09:05:32 INFO - PROCESS | 23582 | 09:05:34 INFO - PROCESS | 23582 | Cycle 1(1): loaded http://localhost:39370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39370/tests/kraken/driver.html?testName=ai-astar) 09:05:34 INFO - PROCESS | 23582 | RSS: Main: 168079360 09:05:34 INFO - PROCESS | 23582 | 09:05:34 INFO - PROCESS | 23582 | __start_tp_report 09:05:34 INFO - PROCESS | 23582 | _x_x_mozilla_page_load 09:05:34 INFO - PROCESS | 23582 | _x_x_mozilla_page_load_details 09:05:34 INFO - PROCESS | 23582 | |i|pagename|runs| 09:05:34 INFO - PROCESS | 23582 | |0;ai-astar;110;107;112;111;112;124;111;113;111;111 09:05:34 INFO - PROCESS | 23582 | |1;audio-beat-detection;159;134;171;192;135;153;159;129;178;130 09:05:34 INFO - PROCESS | 23582 | |2;audio-dft;161;163;163;162;164;165;175;163;166;165 09:05:34 INFO - PROCESS | 23582 | |3;audio-fft;77;76;73;151;73;78;73;77;111;74 09:05:34 INFO - PROCESS | 23582 | |4;audio-oscillator;93;94;157;92;94;93;155;93;94;154 09:05:34 INFO - PROCESS | 23582 | |5;imaging-gaussian-blur;118;117;119;117;117;117;118;117;118;118 09:05:34 INFO - PROCESS | 23582 | |6;imaging-darkroom;146;147;147;147;147;147;147;147;147;147 09:05:34 INFO - PROCESS | 23582 | |7;imaging-desaturate;95;96;95;95;96;96;94;96;95;95 09:05:34 INFO - PROCESS | 23582 | |8;json-parse-financial;59;62;65;65;62;64;65;77;58;59 09:05:34 INFO - PROCESS | 23582 | |9;json-stringify-tinderbox;62;62;62;62;63;62;62;61;63;63 09:05:34 INFO - PROCESS | 23582 | |10;stanford-crypto-aes;76;78;86;77;80;80;78;86;80;79 09:05:34 INFO - PROCESS | 23582 | |11;stanford-crypto-ccm;128;128;138;126;128;127;123;141;167;148 09:05:34 INFO - PROCESS | 23582 | |12;stanford-crypto-pbkdf2;176;179;177;171;170;178;173;177;170;166 09:05:34 INFO - PROCESS | 23582 | |13;stanford-crypto-sha256-iterative;69;70;72;69;71;69;68;69;71;67 09:05:34 INFO - PROCESS | 23582 | __end_tp_report 09:05:34 INFO - PROCESS | 23582 | __start_cc_report 09:05:34 INFO - PROCESS | 23582 | _x_x_mozilla_cycle_collect,831 09:05:34 INFO - PROCESS | 23582 | __end_cc_report 09:05:34 INFO - PROCESS | 23582 | __startTimestamp1461341134472__endTimestamp 09:05:34 INFO - PROCESS | 23582 | 09:05:34 INFO - PROCESS | 23582 | ------- Summary: start ------- 09:05:34 INFO - PROCESS | 23582 | Number of tests: 14 09:05:34 INFO - PROCESS | 23582 | 09:05:34 INFO - PROCESS | 23582 | [#0] ai-astar Cycles:10 Average:112.20 Median:111.50 stddev:4.44 (4.0%) stddev-sans-first:4.64 09:05:34 INFO - PROCESS | 23582 | Values: 110.0 107.0 112.0 111.0 112.0 124.0 111.0 113.0 111.0 111.0 09:05:34 INFO - PROCESS | 23582 | 09:05:34 INFO - PROCESS | 23582 | [#1] audio-beat-detection Cycles:10 Average:154.00 Median:159.00 stddev:21.91 (13.8%) stddev-sans-first:23.17 09:05:34 INFO - PROCESS | 23582 | Values: 159.0 134.0 171.0 192.0 135.0 153.0 159.0 129.0 178.0 130.0 09:05:34 INFO - PROCESS | 23582 | 09:05:34 INFO - PROCESS | 23582 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:3.92 (2.4%) stddev-sans-first:3.92 09:05:34 INFO - PROCESS | 23582 | Values: 161.0 163.0 163.0 162.0 164.0 165.0 175.0 163.0 166.0 165.0 09:05:34 INFO - PROCESS | 23582 | 09:05:34 INFO - PROCESS | 23582 | [#3] audio-fft Cycles:10 Average:86.30 Median:75.00 stddev:25.44 (33.9%) stddev-sans-first:26.76 09:05:34 INFO - PROCESS | 23582 | Values: 77.0 76.0 73.0 151.0 73.0 78.0 73.0 77.0 111.0 74.0 09:05:34 INFO - PROCESS | 23582 | 09:05:34 INFO - PROCESS | 23582 | [#4] audio-oscillator Cycles:10 Average:111.90 Median:93.00 stddev:29.99 (32.2%) stddev-sans-first:31.02 09:05:34 INFO - PROCESS | 23582 | Values: 93.0 94.0 157.0 92.0 94.0 93.0 155.0 93.0 94.0 154.0 09:05:34 INFO - PROCESS | 23582 | 09:05:34 INFO - PROCESS | 23582 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 09:05:34 INFO - PROCESS | 23582 | Values: 118.0 117.0 119.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 09:05:34 INFO - PROCESS | 23582 | 09:05:34 INFO - PROCESS | 23582 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.32 (0.2%) stddev-sans-first:0.00 09:05:34 INFO - PROCESS | 23582 | Values: 146.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 09:05:34 INFO - PROCESS | 23582 | 09:05:34 INFO - PROCESS | 23582 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:05:34 INFO - PROCESS | 23582 | Values: 95.0 96.0 95.0 95.0 96.0 96.0 94.0 96.0 95.0 95.0 09:05:34 INFO - PROCESS | 23582 | 09:05:34 INFO - PROCESS | 23582 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.50 stddev:5.42 (8.4%) stddev-sans-first:5.49 09:05:34 INFO - PROCESS | 23582 | Values: 59.0 62.0 65.0 65.0 62.0 64.0 65.0 77.0 58.0 59.0 09:05:34 INFO - PROCESS | 23582 | 09:05:34 INFO - PROCESS | 23582 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 09:05:34 INFO - PROCESS | 23582 | Values: 62.0 62.0 62.0 62.0 63.0 62.0 62.0 61.0 63.0 63.0 09:05:34 INFO - PROCESS | 23582 | 09:05:34 INFO - PROCESS | 23582 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:3.43 (4.3%) stddev-sans-first:3.32 09:05:34 INFO - PROCESS | 23582 | Values: 76.0 78.0 86.0 77.0 80.0 80.0 78.0 86.0 80.0 79.0 09:05:34 INFO - PROCESS | 23582 | 09:05:34 INFO - PROCESS | 23582 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:133.00 stddev:13.63 (10.2%) stddev-sans-first:14.19 09:05:34 INFO - PROCESS | 23582 | Values: 128.0 128.0 138.0 126.0 128.0 127.0 123.0 141.0 167.0 148.0 09:05:34 INFO - PROCESS | 23582 | 09:05:34 INFO - PROCESS | 23582 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:176.50 stddev:4.32 (2.4%) stddev-sans-first:4.50 09:05:34 INFO - PROCESS | 23582 | Values: 176.0 179.0 177.0 171.0 170.0 178.0 173.0 177.0 170.0 166.0 09:05:34 INFO - PROCESS | 23582 | 09:05:34 INFO - PROCESS | 23582 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.51 (2.2%) stddev-sans-first:1.59 09:05:34 INFO - PROCESS | 23582 | Values: 69.0 70.0 72.0 69.0 71.0 69.0 68.0 69.0 71.0 67.0 09:05:34 INFO - PROCESS | 23582 | -------- Summary: end -------- 09:05:34 INFO - PROCESS | 23582 | 09:05:35 INFO - TEST-INFO | 23582: exit 0 09:05:35 INFO - TEST-OK | kraken | took 61655ms 09:05:35 INFO - SUITE-END | took 1171s 09:05:35 INFO - Completed test suite (00:19:31) 09:05:35 INFO - javascript benchmark 09:05:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3069.86185621647, 3120.6411262704783, 3133.529970504425, 3160.6997335253145, 3162.636296825866, 5252.107141785896, 5268.525832675058, 5271.288376069229, 5280.4983526564965, 5301.469853014697, 5261.552768014713, 5264.657797243177, 5286.259923610698, 5366.570674346052, 5377.677339359641, 4758.0, 4789.736564488951, 4845.127876982142, 4887.535684110004, 4919.680220785655, 4833.0, 4958.281049247857, 4964.875878103058, 5004.224345226496, 5005.449400565934, 4768.73771942543, 4801.687890287155, 4849.490803465621, 4899.338589290436, 4905.4849240829735, 4825.324454576362, 4856.441509226449, 4864.586510146642, 4876.049170411771, 4914.36113305268, 4819.42166939966, 4828.903421931542, 4854.68444551103, 4855.757212139414, 4881.511848815126, 5065.392152941634, 5160.354955630546, 5233.031889100491, 5236.8690782730355, 5241.764120614582, 5564.610477266593, 5600.915986260209, 5614.0, 5634.126710359901, 5637.041702910515, 5513.807016754395, 5671.716414179275, 5684.090545512699, 5692.089265717506, 5692.857678558028, 5199.792008319662, 5247.081760691902, 5296.020236256267, 5296.867578310535, 5299.73501324936, 5698.601097923189, 5724.914126288109, 5727.5131613812455, 5739.569532285095, 5750.4249575042995, 5419.756110974937, 5525.226468294442, 5526.58550608706, 5528.86177845549, 5586.357568879631, 5645.661260324394, 5670.858228544319, 5677.977963966526, 5697.601167918288, 5700.23046888673, 5582.665040097607, 5591.077472217039, 5615.550755939515, 5618.494335509824, 5628.127640215773, 5578.191162281447, 5590.217369568264, 5646.520045796071, 5670.489655930986, 5680.6307590007345, 4235.830566777356, 4258.254805409041, 4261.680373971964, 4263.8081286342185, 4302.569743025672, 3855.6722678572637, 3858.421236814444, 3869.5356557213313, 3875.5349358076646, 3880.3791393377487, 5313.123334649817, 5324.547413469821, 5402.972985135128, 5420.4759125980145, 5468.562514998791, 5689.601727879009, 5734.799282025109, 5739.454751798572, 5747.281589801275, 5794.449527294901, 5440.591955603346, 5448.918266225931, 5449.918251226235, 5453.563714902798, 5456.399796022434, 4800.903981920342, 4880.0, 4890.462049174588, 4931.654784165145, 4936.308916751657, 5844.9415505845245, 5862.179294898718, 5869.442402971711, 5878.735456904449, 5934.0, 5693.544516438675, 5703.344115426779, 5703.914441283301, 5708.857278568069, 5716.885662286814, 5705.258316418839, 5814.883702326015, 5858.502027327725, 5859.736311865891, 5917.763289468373, 5546.112621980464, 5548.306461692288, 5557.722113894209, 5558.277423934863, 5563.888722225452, 5598.552115830806, 5643.435656434323, 5649.548036157015, 5654.886902261849, 5660.179274005164, 5502.284702988586, 5537.612367134262, 5581.5255703265675, 5587.776488940397, 5632.127020311858, 5418.783248670009, 5543.667379957215, 5548.861278468071, 5578.135389014709, 5605.32736071674, 5409.7024663642305, 5431.646942948696, 5443.183522471661, 5470.452954704498, 5475.479829416199, 5470.863228419322, 5544.667319960815, 5556.499915007668, 5568.136938774496, 5623.775048997994, 5446.591505637014, 5473.480019398151, 5477.561795056466, 5483.588730845282, 5515.944840551543], "value": 5226.457292854961, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.7807150390106, 653.7744478155037, 656.6552559906046, 662.3442791636281, 685.3626127701236, 36411.81794091029, 37532.81233593835, 37593.62406375935, 37753.62246377532, 37767.24465510688, 40277.194456110934, 40536.189276214456, 40582.59417405825, 40843.38734918978, 41086.17827643445, 8410.537420441888, 8513.063563008096, 8541.103184165666, 8579.099194584573, 8595.054544000155, 8471.830563388728, 8530.957345213264, 8547.615357308905, 8548.74353769388, 8601.268892144175, 8607.225349718525, 8657.26413254874, 8674.826503469927, 8682.479051256912, 8685.652573897036, 8545.914540854574, 8547.700830470903, 8569.957150214272, 8582.613782379807, 8597.699080532151, 8476.957615211884, 8501.277391421736, 8538.786530336729, 8561.700340488116, 8579.957100214458, 31217.531737023965, 37533.24933501315, 37926.43110353347, 37967.81016094902, 38040.42939355884, 2944.322805754667, 3079.5842561254167, 3142.3872344892757, 3272.541844141822, 3342.181165614416, 28101.718982810115, 28253.0, 28386.29034274139, 28918.0, 29436.0, 3789.4315852622053, 3931.2923673738715, 3936.8228429720443, 3989.920201595981, 4002.679785617144, 255114.0, 259722.0, 259835.0, 260299.0, 260763.0, 35115.0, 36185.276294473966, 57550.0, 57930.0, 58375.0, 33849.32301353959, 33937.64249429995, 34031.14922126967, 34046.14884627855, 34216.14459638529, 15516.689666206612, 15742.9212853935, 15752.92123539375, 15799.447019354267, 15813.762793558106, 13376.598702038955, 13419.396127174301, 13422.328883555783, 13441.126326788728, 13504.864951350557, 8439.95780021096, 8502.872456913152, 8520.360972927056, 8573.828523429496, 8617.35369847264, 3212.1969507623094, 3225.3549290142064, 3248.6751324867796, 3270.787398819069, 3281.753868459875, 1088.613542192526, 1126.3467189030343, 1137.5536640444666, 1138.6470194239812, 1143.5482984221353, 30137.246568835515, 30576.69423305783, 31854.0, 31902.361952760813, 31990.0, 1171.7832201042834, 1173.0146676791537, 1183.5147589488267, 1233.9814902776466, 1301.8763217494322, 16346.75479867803, 16775.412860550066, 16796.664066718597, 16851.57871053209, 17255.56861078483, 214780.0, 216698.0, 218516.0, 218747.0, 461916.0, 56605.15092273619, 57357.0, 57471.0, 57511.42488575061, 57551.424485755444, 1339.8928085753116, 1381.5924302330836, 1404.2978510744629, 1404.7611905975805, 1420.4460260498413, 29063.273418164714, 30388.24029399283, 30621.54067689031, 31051.0, 31141.532877007317, 51361.22958155556, 51674.74162629163, 51774.0, 51828.481715182366, 52048.0, 390420.0, 390820.0, 392158.0, 392882.0, 395290.0, 28319.2920176989, 28555.28611784722, 28643.713562864104, 28978.855105724335, 29030.12909612715, 47308.0, 47720.2841957364, 47966.406718657105, 48488.0, 48511.75744121257, 39582.0, 39859.202815944096, 40281.0, 40597.39103913384, 41168.38247426351, 39027.0, 40910.0, 41318.1736365277, 41681.79159104185, 41772.0, 35979.10052248715, 42222.57777422186, 42295.0, 43264.0, 43399.34900976551, 31131.84434077906, 31525.684743152276, 33334.0, 34066.82966585151, 34255.82872085624, 26569.867150664122, 27249.72750272472, 27598.44803103967, 28025.29936751516, 28115.297117572223], "value": 17876.49548480277, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.9677027452667, 381.6793893129772, 391.59469948603197, 393.38042582931854, 395.1405692618554, 13884.652883677913, 16891.0, 17146.31414743409, 19013.429597112092, 19197.0, 17897.46307610774, 17964.0, 18271.451856444328, 18289.634207315845, 18873.339433119843, 5311.49540793625, 5489.560835133179, 5494.066008778497, 5517.944820551783, 5539.473749993744, 5514.889702205954, 5554.583406244527, 5720.599558030939, 5721.34204566476, 5727.198192253088, 5639.436056394348, 5653.547716182716, 5656.519195868356, 5660.009498337795, 5663.631863928852, 5442.591805614575, 5664.490195882349, 5667.716614169275, 5667.971660141693, 5668.206451096849, 4877.268409738532, 5011.3485246918035, 5018.146915024418, 5033.647644664875, 5039.0, 16936.40722574704, 22179.0, 22378.552428951494, 22455.0, 22596.548069038527, 2327.394877331889, 2590.7020692620404, 2606.478704259137, 2805.7615102716295, 3118.8128712277335, 13915.930420347935, 14034.508792192326, 14156.150630962175, 14233.928830355782, 14398.352074156688, 1783.3401641392768, 1862.1527205121638, 1881.595456976743, 1920.4526709887614, 1924.4611508777564, 74171.62914185449, 74581.25418745851, 74992.25007749908, 75439.0, 76256.0, 9991.0, 10060.993900610027, 10216.284860059874, 10456.64063671733, 10522.526486308134, 14254.0, 14310.928445357707, 14322.856771432153, 14366.35351409189, 14377.856221437862, 8104.797380065427, 8170.101288858221, 8214.83570328602, 8335.249827515552, 8413.915860841313, 8218.947784810032, 8298.170182981654, 8298.626561804733, 8386.496810191285, 8441.746747597583, 6332.908417320668, 6363.713632886439, 6373.458256048288, 6439.774607888701, 6450.612963222222, 1794.6949018666858, 1809.4481183239238, 1816.954576135607, 1841.3831366492375, 1846.2430403534486, 1022.0392830739081, 1039.1323245090282, 1084.7450849050467, 1102.3000394749392, 1104.5913012185542, 18915.527111822314, 19104.904475477535, 19284.421467356, 19391.3213037543, 19783.0, 1055.1822337688352, 1080.9567617295377, 1092.4865313302735, 1103.862017247844, 1124.3591153042687, 10972.396518191417, 11326.207165498336, 11336.263142895685, 11412.885871141183, 11425.942870285762, 454817.0, 463078.0, 488789.0, 490286.0, 490348.0, 77086.0, 77907.0, 78650.60674696704, 78765.60617196992, 79492.6025369881, 1077.7952189084049, 1091.1543553745753, 1094.0864378244096, 1094.4691824465128, 1107.4075369677184, 17060.493382911478, 17094.230759616097, 17209.225584848962, 17209.483715488554, 17351.739723904404, 36404.63595364012, 36607.0, 36920.26159476849, 37124.0, 37715.81142094272, 46065.53934460747, 54386.728066359414, 58153.418465816496, 59454.405455944885, 60322.09516857163, 5578.721063946705, 7667.463277570517, 7938.285554300141, 8195.67217311301, 8503.0, 13163.0, 13376.0, 13406.530771422953, 13474.124181928144, 13495.392707327997, 11389.943050284695, 11588.420578971187, 11606.30362178272, 11681.0, 11954.58158964432, 11103.888961110608, 11353.262037967506, 11357.54569817198, 11611.709707257387, 11685.591004314809, 11544.538218471167, 11698.532058717556, 11907.642770716893, 11917.76164476723, 12046.698832529257, 8078.111407745261, 8115.229053239933, 8128.9593552031865, 8162.061362943337, 8638.0, 9872.605095796087, 11447.198696091195, 11753.764924701629, 11822.881771182178, 12039.0], "value": 9171.4319650297, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.2506821521022, 1491.1500444746491, 1640.983590164098, 1748.1346733366986, 1785.9017754023523, 6726.562773419724, 7703.961480192598, 7766.0, 7875.527468351903, 7884.881726774103, 7860.292573668368, 7864.528128312305, 7922.0, 7922.881156782653, 7937.642806073726, 2198.428408613764, 2220.7779222077825, 2221.300290408516, 2221.80003799658, 2229.8662080275235, 2167.9783202167932, 2173.1633321171385, 2184.0, 2211.8783466909313, 2212.590670725913, 2146.302451703195, 2169.4359466538735, 2174.239016344283, 2174.4781252499365, 2185.945351366213, 2146.3131797824703, 2158.579077079962, 2161.8919054047315, 2164.426426996847, 2167.4473009382664, 2129.5634394948997, 2138.8716676999275, 2142.7107340508987, 2143.9892800536054, 2151.214806595597, 7976.840463190703, 8025.357971362277, 8035.517868927883, 8044.517328960223, 8044.919550804534, 4805.135075686375, 4925.876853078702, 4988.575971042465, 5013.04752097104, 5015.448300686921, 3232.337370838972, 3247.7888937219004, 3254.1376535218187, 3265.9183520411943, 3271.06774569249, 1077.13828936851, 1090.1442367741286, 1124.7694222684331, 1129.4917287220783, 1983.9008049597608, 10552.419616921066, 10570.365778053265, 10575.312604680672, 10622.36265824053, 10629.893701063045, 4114.691398145151, 4218.810153543098, 4380.6933514653665, 4402.449693788277, 4410.117976404732, 8380.371472139492, 8391.0, 8401.327893768485, 8457.323414126855, 8481.787955301043, 4797.664163508591, 4802.943352462453, 4823.445303790038, 4849.466558678542, 4857.927131093036, 3899.395593682984, 4503.437070366204, 4508.797104130322, 4518.277075667877, 4565.885852853638, 3607.783532988029, 3639.1993761372987, 3704.759190652599, 3717.275131349361, 3724.944125838115, 1104.7900898829196, 1121.097516499226, 1125.5722825326488, 1128.1313388690662, 1128.700894263021, 804.6137853830078, 896.2068569316202, 934.4860326820221, 936.6440752514001, 962.7352478068448, 5319.521243088141, 5338.626296159309, 5358.785648574091, 5400.351957765093, 5404.054290499147, 400.46737838675074, 405.6815399911056, 417.6825612534435, 418.5563302898937, 418.82200064972267, 3619.3666108431444, 3737.4580685800406, 3749.2126653402547, 3762.9059273518383, 3791.3175628386603, 9377.578008989612, 9888.406695598287, 9916.553755081039, 9950.850737238947, 9982.101610855058, 9713.90286097144, 9803.852942205873, 9807.0, 9810.21518278536, 9830.361026533252, 7259.637018149071, 7472.402207823361, 7492.850142997109, 7552.207018263113, 7674.57789821554, 5257.763400647056, 5342.732863356894, 5402.108652072364, 5454.509094181542, 5521.751521181476, 8392.244697977212, 8399.244068033662, 8438.0, 8503.0, 8621.784455388666, 8304.667813287642, 8838.955805220932, 9099.317551183556, 9179.632814687338, 9184.21934135606, 6363.331850155667, 6874.862502749817, 7037.225905150532, 7329.157146927958, 7626.0, 7832.255935686101, 7844.137144913941, 7856.25365590268, 7883.881741773993, 7913.762587122395, 6730.394264516021, 6870.038194652852, 6969.58182509051, 7147.53541019832, 7200.675969581486, 7037.1555413350725, 7118.181409137808, 7150.606716630636, 7189.209186989322, 7189.964050179716, 6087.9391206087375, 6305.4009869062365, 6315.936840631535, 6411.198600174978, 6542.5747326425535, 4762.095201911626, 4849.369581954324, 4864.124457597525, 4888.755562221946, 4971.627127965345, 4853.174960256835, 4899.387576552931, 4939.0, 4982.153033984304, 5042.520960508746], "value": 4187.816576624873, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.77705994333945, 323.69734298430967, 331.1423413359399, 332.10000897567585, 337.6033161035782, 5874.206982057421, 5991.850203744903, 5992.932438308782, 5997.31030931443, 6114.266288045435, 5976.760929562813, 6005.3394126646035, 6029.366916473773, 6039.5168386529085, 6044.969775151129, 4585.79363928624, 4606.608438282741, 4607.838725644603, 4614.792334344946, 4625.398698169233, 4477.6417886569, 4620.353150558924, 4633.443986721598, 4636.0, 4637.536246375353, 4561.543845615445, 4583.862484125481, 4587.42657167854, 4598.82729903874, 4616.6306695464455, 4552.863414097583, 4583.472900616405, 4591.701539399928, 4602.792874320664, 4610.354550362918, 3687.8524859005875, 3885.941710874339, 3901.317269477858, 4045.3122969095325, 4058.959410405888, 5743.339515955677, 5781.624194427391, 5799.623024503394, 5799.8550036249435, 5800.100984347433, 5194.182036287307, 5198.6880787152895, 5207.973960130175, 5209.400918894337, 5226.660267082665, 5938.257717785277, 6245.156903817971, 6321.0, 6321.0834429008, 6327.114204011442, 4298.935515967263, 4300.0, 4310.224159651261, 4318.935215971763, 4319.784010799447, 6269.868244796837, 6514.5114116441455, 6565.54041217115, 6581.111549940744, 6585.078089067534, 4348.130373925228, 4350.086481838786, 4352.69531132824, 4390.407295015132, 4396.3625274335045, 4380.123975204971, 4404.955950440519, 4406.62543683784, 4409.470863496337, 4419.64642828573, 5050.141475949024, 5142.51146141116, 5182.067227898939, 5184.662996905189, 5209.6353255272525, 6128.111423843607, 6357.618542887441, 6383.489081005521, 6390.265119511316, 6392.296847346788, 1507.3367718203956, 1527.9159646219564, 1529.4417537598697, 1532.6934613077206, 1544.6138465383654, 1005.0903931941605, 1018.4703953944056, 1026.3585259212991, 1028.136365453008, 1045.9372437653765, 6059.48494377974, 6093.146959425684, 6101.206843110456, 6122.632642041492, 6136.969315153396, 6419.679016049179, 6480.351964803482, 6495.863223935792, 6504.089427480157, 6532.346765323429, 5947.345791962881, 6080.9391906081255, 6134.294556126102, 6137.9182843408635, 6144.385561443909, 3483.9444727610326, 3499.5975462822103, 3510.754247202671, 3513.4905438711244, 3522.5244591980268, 6521.380468855451, 6709.496787740939, 6734.0, 6740.12378390806, 6749.730010799612, 6615.470762339001, 6623.43700785429, 6631.966840165768, 6642.63465509392, 6654.26803051664, 6578.967105164444, 6701.229358623723, 6734.393904548614, 6752.088468056848, 6754.662266886734, 6466.935330646822, 6498.642574658439, 6508.772192973223, 6524.217093948567, 6527.771527996498, 6261.869065467266, 6410.839729006812, 6418.935810641834, 6440.710168042543, 6443.323451037573, 6650.866982660223, 6671.566348187353, 6682.064510968371, 6692.694924489872, 6698.966505167443, 4317.546657600907, 4359.673024523237, 4373.453318335208, 4377.759223242625, 4404.1411924674385, 6262.029385445263, 6284.277308109626, 6431.941778630793, 6442.484601231797, 6474.935250647622, 6377.266614339224, 6380.649064301508, 6385.616862988236, 6406.23125224976, 6414.005829096497, 6254.466940888948, 6386.978083506617, 6390.169277993831, 6392.488600911823, 6424.357564243538, 6180.443760061616, 6206.813795586139, 6214.347493513116, 6214.564980451506, 6275.309715931153, 6337.7148028337915, 6406.711697973509, 6407.519436042222, 6446.935530644633, 6463.450606698295, 5981.162637230878, 6218.782342617987, 6308.495320374267, 6327.873442531216, 6376.171097757262], "value": 4739.730086588477, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.1562690428858, 824.2375802382791, 824.6866190847477, 847.3179090831878, 848.5375470368652, 12519.499220031199, 12689.809652855214, 12705.491780328775, 12718.1733187343, 12825.358732063394, 10445.84331235032, 12665.303408312539, 12738.872611273884, 12741.490340386397, 12741.554045608405, 788.388998526144, 810.4934415990007, 816.7141500474846, 816.8693009118542, 817.0726225733775, 801.3348920396057, 803.6263137640996, 804.6459557794581, 804.8712206047034, 807.8909347238135, 842.540815255684, 842.970496032639, 844.9704260350888, 845.2392846438194, 848.9023762267326, 834.7287131682198, 841.0538144587339, 841.2260720137489, 842.7429633961639, 843.1020962674731, 612.0268772651506, 615.4430240632234, 617.4473845907933, 618.6380967134232, 620.3455354600894, 13257.403416846266, 13293.0, 13296.800547991692, 13298.867011329956, 13310.401031953585, 12782.488700451971, 12800.295983720891, 13164.473421063147, 13307.733845323039, 13324.400401981935, 11981.580644677482, 11983.340916249603, 12093.153479256456, 12143.696407589792, 12249.265044097383, 4281.357796330544, 4291.4850217973735, 4382.364557139229, 4412.249917513998, 4418.204723149832, 52168.0, 54949.901001980135, 56559.151612725844, 56833.43166568364, 56855.0, 10498.790024199627, 11045.558177672963, 11258.43707814606, 11283.60507382254, 11316.6039188628, 18545.53636159107, 18646.906765466087, 18736.344227951955, 18803.0, 18894.905525472284, 7804.2195780422635, 7813.453058285865, 8270.37972152079, 8283.25450709439, 8378.539180345018, 4338.284183109751, 4513.526079761644, 4515.954840451619, 4571.611413029863, 4702.482726900038, 3062.632484101922, 3118.0334096429724, 3120.547520609499, 3138.9686103138674, 3139.8116113033293, 567.2172402085179, 571.0777094991558, 571.3030103273999, 593.9495142912814, 622.4211483320465, 644.255884453457, 691.6126968897433, 740.9962950185322, 752.3266676324658, 755.4296506137831, 7977.282044615897, 8637.385654653432, 8746.0, 8862.0, 8883.822323553493, 659.7954634063456, 714.6676795290111, 750.936170425509, 752.665064046505, 753.898223739799, 4173.0, 4302.913941721211, 4317.891118394751, 4333.306670932636, 4347.717398369159, 69030.0, 69846.0, 70714.64642676753, 71660.64169679118, 71935.64032179806, 59395.703021484616, 59716.70141649264, 61102.38897610967, 61918.0, 62104.06843897345, 54332.0, 54785.45214547803, 54981.0, 55987.16019259714, 56546.71726641423, 8209.302209312036, 8344.541050242295, 8361.247487726134, 8452.154784521745, 8515.616797244264, 31566.0, 31753.8412307937, 32641.0, 33411.49882751712, 36194.0, 44276.33585496156, 44772.32841507315, 44924.326135108655, 44937.550624494645, 45261.868453287614, 11152.884711528783, 11239.438028098399, 11550.768984620428, 11750.471228794553, 11953.103517236068, 11599.304041757521, 11724.70688232801, 11834.349110798988, 11859.525618975144, 12717.109802314118, 11447.084233261152, 11865.0, 11872.347020913587, 11885.643430697093, 12910.289934053717, 11982.940085299866, 12062.819057714318, 12080.21478603888, 12182.878171218174, 12639.873601264237, 12274.263544187377, 12424.689382765504, 12485.812712809133, 12573.49706011786, 12655.746885062432, 9582.329236953346, 9703.66037188695, 9886.604535818775, 9891.950540247253, 10210.0, 9660.855087173557, 9795.16741076988, 9828.0, 9838.016198380104, 9913.45475998827], "value": 6624.954200631767, "unit": "score"}], "name": "dromaeo_css", "value": 6949.95449498925, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 112.0, 111.0, 112.0, 124.0, 111.0, 113.0, 111.0, 111.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 134.0, 171.0, 192.0, 135.0, 153.0, 159.0, 129.0, 178.0, 130.0], "value": 154.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 162.0, 164.0, 165.0, 175.0, 163.0, 166.0, 165.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 73.0, 151.0, 73.0, 78.0, 73.0, 77.0, 111.0, 74.0], "value": 86.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 157.0, 92.0, 94.0, 93.0, 155.0, 93.0, 94.0, 154.0], "value": 111.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 94.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 65.0, 65.0, 62.0, 64.0, 65.0, 77.0, 58.0, 59.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 61.0, 63.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 86.0, 77.0, 80.0, 80.0, 78.0, 86.0, 80.0, 79.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 138.0, 126.0, 128.0, 127.0, 123.0, 141.0, 167.0, 148.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 179.0, 177.0, 171.0, 170.0, 178.0, 173.0, 177.0, 170.0, 166.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 72.0, 69.0, 71.0, 69.0, 68.0, 69.0, 71.0, 67.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1573.3, "alertThreshold": 2.0}]} 09:05:35 INFO - Return code: 0 09:05:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:05:35 ERROR - # TBPL SUCCESS # 09:05:35 INFO - Running post-action listener: _resource_record_post_action 09:05:35 INFO - Running post-run listener: _resource_record_post_run 09:05:36 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 532697088; Read time: 0; Write time: 513032 09:05:36 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244518912; Read time: 0; Write time: 308744 09:05:36 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 288063488; Read time: 0; Write time: 204288 09:05:36 INFO - Running post-run listener: _upload_blobber_files 09:05:36 INFO - Blob upload gear active. 09:05:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:05:36 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 09:05:36 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:05:36 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:05:37 INFO - (blobuploader) - INFO - Open directory for files ... 09:05:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:05:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:05:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:38 INFO - (blobuploader) - INFO - Done attempting. 09:05:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:05:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:05:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:38 INFO - (blobuploader) - INFO - Done attempting. 09:05:38 INFO - (blobuploader) - INFO - Iteration through files over. 09:05:38 INFO - Return code: 0 09:05:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:05:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:05:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a039c44f56c8aec6207503fcb0430fd07614dd20abd44b5eb52b268154d8b7f79eb4012bdfb09984beb9d937c6d6f38ca51996afddb08cdc87e99c0fbce5fa9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b61a7b143d6beb52aa78520f1babec00f79c3933c8895e3149228c6dcffc40826ce60de610775553ccdde46713864def0642c35a5b2a23165c33d3e0c7557c38"} 09:05:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:05:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:05:38 INFO - Contents: 09:05:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a039c44f56c8aec6207503fcb0430fd07614dd20abd44b5eb52b268154d8b7f79eb4012bdfb09984beb9d937c6d6f38ca51996afddb08cdc87e99c0fbce5fa9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b61a7b143d6beb52aa78520f1babec00f79c3933c8895e3149228c6dcffc40826ce60de610775553ccdde46713864def0642c35a5b2a23165c33d3e0c7557c38"} 09:05:38 INFO - Running post-run listener: copy_logs_to_upload_dir 09:05:38 INFO - Copying logs to upload dir... 09:05:38 INFO - mkdir: /builds/slave/test/build/upload/logs 09:05:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.688324 ========= master_lag: 55.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-04-22 09:06:33.103555) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-22 09:06:33.107747) ========= 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=1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a039c44f56c8aec6207503fcb0430fd07614dd20abd44b5eb52b268154d8b7f79eb4012bdfb09984beb9d937c6d6f38ca51996afddb08cdc87e99c0fbce5fa9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b61a7b143d6beb52aa78520f1babec00f79c3933c8895e3149228c6dcffc40826ce60de610775553ccdde46713864def0642c35a5b2a23165c33d3e0c7557c38"} build_url:https://queue.taskcluster.net/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/PCynQOaYSaqsENK_AeK-MA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a039c44f56c8aec6207503fcb0430fd07614dd20abd44b5eb52b268154d8b7f79eb4012bdfb09984beb9d937c6d6f38ca51996afddb08cdc87e99c0fbce5fa9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b61a7b143d6beb52aa78520f1babec00f79c3933c8895e3149228c6dcffc40826ce60de610775553ccdde46713864def0642c35a5b2a23165c33d3e0c7557c38"}' ========= master_lag: 1.29 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-22 09:06:34.404995) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 09:06:34.405328) ========= 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=1f5564757af27664ca02d71f000001b0-1461339902.805560-2100262557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 09:06:34.545892) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-22 09:06:34.546224) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-22 09:06:35.822949) ========= ========= Total master_lag: 56.51 =========