builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1463263157.56 results: success (0) buildid: 20160514134428 builduid: ce9cd6424b794c1ca0cde549eee679f1 revision: c67242e935ee610b6f6a6e37596a274bc9ed2c9f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 14:59:17.559341) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 14:59:17.559868) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 14:59:17.560163) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 14:59:17.578883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:59:17.579268) ========= 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=52faae308a556c440401f8e5000001e8-1463263159.334392-127088963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-14 14:59:20-- 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% 46.5M=0s 2016-05-14 14:59:20 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123763 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:59:17.716345) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:59:17.716676) ========= 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=52faae308a556c440401f8e5000001e8-1463263159.334392-127088963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016702 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:59:17.767241) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:59:17.767586) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c67242e935ee610b6f6a6e37596a274bc9ed2c9f --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 c67242e935ee610b6f6a6e37596a274bc9ed2c9f --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=52faae308a556c440401f8e5000001e8-1463263159.334392-127088963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-14 14:59:20,281 truncating revision to first 12 chars 2016-05-14 14:59:20,281 Setting DEBUG logging. 2016-05-14 14:59:20,281 attempt 1/10 2016-05-14 14:59:20,281 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c67242e935ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-14 14:59:20,512 unpacking tar archive at: fx-team-c67242e935ee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.509073 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:59:18.292717) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 14:59:18.293535) ========= script_repo_revision: c67242e935ee610b6f6a6e37596a274bc9ed2c9f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 14:59:18.294389) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 14:59:18.294678) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 14:59:18.305322) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-14 14:59:18.305961) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1463263159.334392-127088963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:59:20 INFO - MultiFileLogger online at 20160514 14:59:20 in /builds/slave/test 14:59:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:59:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:59:20 INFO - {'append_to_log': False, 14:59:20 INFO - 'base_work_dir': '/builds/slave/test', 14:59:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:59:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:59:20 INFO - 'branch': 'Fx-Team-Non-PGO', 14:59:20 INFO - 'buildbot_json_path': 'buildprops.json', 14:59:20 INFO - 'config_files': ('talos/linux_config.py',), 14:59:20 INFO - 'default_actions': ('clobber', 14:59:20 INFO - 'read-buildbot-config', 14:59:20 INFO - 'download-and-extract', 14:59:20 INFO - 'populate-webroot', 14:59:20 INFO - 'create-virtualenv', 14:59:20 INFO - 'install', 14:59:20 INFO - 'run-tests'), 14:59:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:59:20 INFO - 'download_minidump_stackwalk': True, 14:59:20 INFO - 'download_symbols': 'ondemand', 14:59:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:59:20 INFO - 'tooltool.py': '/tools/tooltool.py', 14:59:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:59:20 INFO - '/tools/misc-python/virtualenv.py')}, 14:59:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:59:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:59:20 INFO - 'installer_path': 'installer.exe', 14:59:20 INFO - 'log_level': 'info', 14:59:20 INFO - 'log_name': 'talos', 14:59:20 INFO - 'log_to_console': True, 14:59:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:59:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:59:20 INFO - 'opt_config_files': (), 14:59:20 INFO - 'pip_index': False, 14:59:20 INFO - 'sps_profile': False, 14:59:20 INFO - 'sps_profile_interval': 0, 14:59:20 INFO - 'suite': 'dromaeojs-e10s', 14:59:20 INFO - 'system_bits': '32', 14:59:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:59:20 INFO - 'title': 'talos-linux64-ix-056', 14:59:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:59:20 INFO - 'use_talos_json': True, 14:59:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:59:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:59:20 INFO - 'work_dir': 'build'} 14:59:20 INFO - ##### 14:59:20 INFO - ##### Running clobber step. 14:59:20 INFO - ##### 14:59:20 INFO - Running pre-action listener: _resource_record_pre_action 14:59:20 INFO - Running main action method: clobber 14:59:20 INFO - rmtree: /builds/slave/test/build 14:59:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:59:21 INFO - Running post-action listener: _resource_record_post_action 14:59:21 INFO - ##### 14:59:21 INFO - ##### Finished clobber step (success) 14:59:21 INFO - ##### 14:59:21 INFO - ##### 14:59:21 INFO - ##### Running read-buildbot-config step. 14:59:21 INFO - ##### 14:59:21 INFO - Running pre-action listener: _resource_record_pre_action 14:59:21 INFO - Running main action method: read_buildbot_config 14:59:21 INFO - Using buildbot properties: 14:59:21 INFO - { 14:59:21 INFO - "project": "", 14:59:21 INFO - "product": "firefox", 14:59:21 INFO - "script_repo_revision": "production", 14:59:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:59:21 INFO - "repository": "", 14:59:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 14:59:21 INFO - "buildid": "20160514134428", 14:59:21 INFO - "pgo_build": "False", 14:59:21 INFO - "basedir": "/builds/slave/test", 14:59:21 INFO - "buildnumber": 1267, 14:59:21 INFO - "slavename": "talos-linux64-ix-056", 14:59:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:59:21 INFO - "platform": "ubuntu64_hw", 14:59:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:59:21 INFO - "branch": "fx-team", 14:59:21 INFO - "repo_path": "integration/fx-team", 14:59:21 INFO - "revision": "c67242e935ee610b6f6a6e37596a274bc9ed2c9f", 14:59:21 INFO - "stage_platform": "linux64", 14:59:21 INFO - "builduid": "ce9cd6424b794c1ca0cde549eee679f1", 14:59:21 INFO - "slavebuilddir": "test" 14:59:21 INFO - } 14:59:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:59:21 INFO - Running post-action listener: _resource_record_post_action 14:59:21 INFO - ##### 14:59:21 INFO - ##### Finished read-buildbot-config step (success) 14:59:21 INFO - ##### 14:59:21 INFO - ##### 14:59:21 INFO - ##### Running download-and-extract step. 14:59:21 INFO - ##### 14:59:21 INFO - Running pre-action listener: _resource_record_pre_action 14:59:21 INFO - Running main action method: download_and_extract 14:59:21 INFO - mkdir: /builds/slave/test/build/tests 14:59:21 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')]} 14:59:21 INFO - https://queue.taskcluster.net/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:59:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:59:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:59:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:59:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:59:22 INFO - Downloaded 1361 bytes. 14:59:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:59:22 INFO - Using the following test package requirements: 14:59:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:59:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:59:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:59:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:22 INFO - u'jsshell-linux-x86_64.zip'], 14:59:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:59:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:59:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:59:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:59:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:59:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:59:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:59:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:22 INFO - https://queue.taskcluster.net/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:59:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:59:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:59:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:59:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:59:23 INFO - Downloaded 22448136 bytes. 14:59:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:59:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:59:24 INFO - Return code: 0 14:59:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:59: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')]} 14:59:24 INFO - https://queue.taskcluster.net/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:59:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:59:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:59:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:59:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:59:25 INFO - Downloaded 22448136 bytes. 14:59:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:59:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:59:27 INFO - Return code: 0 14:59: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')]} 14:59:27 INFO - https://queue.taskcluster.net/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:59:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:59:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:59:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:59:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:59:28 INFO - Downloaded 10840194 bytes. 14:59:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:59:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:59:28 INFO - Return code: 0 14:59:28 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')]} 14:59:28 INFO - https://queue.taskcluster.net/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:59:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:59:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:59:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:59:29 INFO - Downloaded 54736526 bytes. 14:59:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:59:29 INFO - mkdir: /builds/slave/test/properties 14:59:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:59:29 INFO - Writing to file /builds/slave/test/properties/build_url 14:59:29 INFO - Contents: 14:59:29 INFO - build_url:https://queue.taskcluster.net/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:59:30 INFO - Running post-action listener: _resource_record_post_action 14:59:30 INFO - Running post-action listener: set_extra_try_arguments 14:59:30 INFO - ##### 14:59:30 INFO - ##### Finished download-and-extract step (success) 14:59:30 INFO - ##### 14:59:30 INFO - ##### 14:59:30 INFO - ##### Running populate-webroot step. 14:59:30 INFO - ##### 14:59:30 INFO - Running pre-action listener: _resource_record_pre_action 14:59:30 INFO - Running main action method: populate_webroot 14:59:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:59:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:59:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:59:30 INFO - '--tppagecycles', 14:59:30 INFO - '7'], 14:59:30 INFO - 'tests': ['tsvgm']}}, 14:59:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:59:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:59:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:59:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:59:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:30 INFO - 'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:59:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:59:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:30 INFO - 'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['damp', 'tps']}, 14:59:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:30 INFO - 'tests': ['damp', 'tps']}, 14:59:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['dromaeo_dom']}, 14:59:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:59:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['a11yr', 14:59:30 INFO - 'ts_paint', 14:59:30 INFO - 'tpaint', 14:59:30 INFO - 'sessionrestore', 14:59:30 INFO - 'sessionrestore_no_auto_restore', 14:59:30 INFO - 'tabpaint']}, 14:59:30 INFO - 'other-e10s': {'tests': ['a11yr', 14:59:30 INFO - 'ts_paint', 14:59:30 INFO - 'tpaint', 14:59:30 INFO - 'sessionrestore', 14:59:30 INFO - 'sessionrestore_no_auto_restore', 14:59:30 INFO - 'tabpaint']}, 14:59:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:59:30 INFO - 'ts_paint', 14:59:30 INFO - 'tpaint', 14:59:30 INFO - 'sessionrestore', 14:59:30 INFO - 'sessionrestore_no_auto_restore', 14:59:30 INFO - 'tabpaint']}, 14:59:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:59:30 INFO - 'ts_paint', 14:59:30 INFO - 'tpaint', 14:59:30 INFO - 'sessionrestore', 14:59:30 INFO - 'sessionrestore_no_auto_restore', 14:59:30 INFO - 'tabpaint']}, 14:59:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['a11yr', 14:59:30 INFO - 'ts_paint', 14:59:30 INFO - 'tpaint', 14:59:30 INFO - 'sessionrestore', 14:59:30 INFO - 'sessionrestore_no_auto_restore', 14:59:30 INFO - 'tabpaint']}, 14:59:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['a11yr', 14:59:30 INFO - 'ts_paint', 14:59:30 INFO - 'tpaint', 14:59:30 INFO - 'sessionrestore', 14:59:30 INFO - 'sessionrestore_no_auto_restore', 14:59:30 INFO - 'tabpaint']}, 14:59:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['tsvgx', 14:59:30 INFO - 'tsvgr_opacity', 14:59:30 INFO - 'tart', 14:59:30 INFO - 'tscrollx', 14:59:30 INFO - 'cart']}, 14:59:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:59:30 INFO - 'tsvgr_opacity', 14:59:30 INFO - 'tart', 14:59:30 INFO - 'tscrollx', 14:59:30 INFO - 'cart']}, 14:59:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:30 INFO - 'talos_options': ['--disable-e10s'], 14:59:30 INFO - 'tests': ['tp5o']}, 14:59:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:30 INFO - 'tests': ['tp5o']}, 14:59:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:30 INFO - 'talos_options': ['--disable-e10s', 14:59:30 INFO - '--xperf_path', 14:59:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:59:30 INFO - 'tests': ['tp5n']}, 14:59:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:30 INFO - 'talos_options': ['--xperf_path', 14:59:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:59:30 INFO - 'tests': ['tp5n']}}, 14:59:30 INFO - 'talos.zip': {'path': '', 14:59:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:59:30 INFO - Running post-action listener: _resource_record_post_action 14:59:30 INFO - ##### 14:59:30 INFO - ##### Finished populate-webroot step (success) 14:59:30 INFO - ##### 14:59:30 INFO - ##### 14:59:30 INFO - ##### Running create-virtualenv step. 14:59:30 INFO - ##### 14:59:30 INFO - Running pre-action listener: _resource_record_pre_action 14:59:30 INFO - Running main action method: create_virtualenv 14:59:30 INFO - Creating virtualenv /builds/slave/test/build/venv 14:59:30 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 14:59:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:59:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:59:30 INFO - Using real prefix '/usr' 14:59:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:59:31 INFO - Installing distribute.............................................................................................................................................................................................done. 14:59:33 INFO - Installing pip.................done. 14:59:33 INFO - Return code: 0 14:59:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:59: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')]} 14:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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')]} 14:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:33 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 0x7ffa50d60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1613770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a29c0>, '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 0x16a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d50>, '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': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', '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 14:59:33 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 14:59:33 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 14:59:33 INFO - Using env: {'DISPLAY': ':0', 14:59:33 INFO - 'HOME': '/home/cltbld', 14:59:33 INFO - 'LANG': 'en_US.UTF-8', 14:59:33 INFO - 'LANGUAGE': 'en_US:en', 14:59:33 INFO - 'LOGNAME': 'cltbld', 14:59:33 INFO - 'MAIL': '/var/mail/cltbld', 14:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:33 INFO - 'MOZ_NO_REMOTE': '1', 14:59:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:33 INFO - 'NO_EM_RESTART': '1', 14:59:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:33 INFO - 'PWD': '/builds/slave/test', 14:59:33 INFO - 'SHELL': '/bin/bash', 14:59:33 INFO - 'SHLVL': '1', 14:59:33 INFO - 'TERM': 'linux', 14:59:33 INFO - 'TMOUT': '86400', 14:59:33 INFO - 'USER': 'cltbld', 14:59:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', 14:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:33 INFO - '_': '/tools/buildbot/bin/python'} 14:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:33 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 14:59:33 INFO - Cleaning up... 14:59:33 INFO - Return code: 0 14:59:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:59: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')]} 14:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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')]} 14:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:33 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa50d60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1613770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a29c0>, '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 0x16a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d50>, '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': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', '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 14:59:33 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>=3.1.1'] in /builds/slave/test/build 14:59:33 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>=3.1.1 14:59:33 INFO - Using env: {'DISPLAY': ':0', 14:59:33 INFO - 'HOME': '/home/cltbld', 14:59:33 INFO - 'LANG': 'en_US.UTF-8', 14:59:33 INFO - 'LANGUAGE': 'en_US:en', 14:59:33 INFO - 'LOGNAME': 'cltbld', 14:59:33 INFO - 'MAIL': '/var/mail/cltbld', 14:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:33 INFO - 'MOZ_NO_REMOTE': '1', 14:59:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:33 INFO - 'NO_EM_RESTART': '1', 14:59:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:33 INFO - 'PWD': '/builds/slave/test', 14:59:33 INFO - 'SHELL': '/bin/bash', 14:59:33 INFO - 'SHLVL': '1', 14:59:33 INFO - 'TERM': 'linux', 14:59:33 INFO - 'TMOUT': '86400', 14:59:33 INFO - 'USER': 'cltbld', 14:59:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', 14:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:33 INFO - '_': '/tools/buildbot/bin/python'} 14:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:33 INFO - Downloading/unpacking psutil>=3.1.1 14:59:33 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 14:59:33 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 14:59:33 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 14:59:33 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 14:59:33 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 14:59:33 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 14:59:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:59:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:59:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:59:35 INFO - Installing collected packages: psutil 14:59:35 INFO - Running setup.py install for psutil 14:59:35 INFO - building 'psutil._psutil_linux' extension 14:59:35 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 14:59:35 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 14:59:35 INFO - building 'psutil._psutil_posix' extension 14:59:35 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 14:59:36 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 14:59:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:59:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:59:36 INFO - Successfully installed psutil 14:59:36 INFO - Cleaning up... 14:59:36 INFO - Return code: 0 14:59:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:59: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')]} 14:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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')]} 14:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:36 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa50d60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1613770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a29c0>, '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 0x16a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d50>, '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': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', '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 14:59:36 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.3'] in /builds/slave/test/build 14:59:36 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.3 14:59:36 INFO - Using env: {'DISPLAY': ':0', 14:59:36 INFO - 'HOME': '/home/cltbld', 14:59:36 INFO - 'LANG': 'en_US.UTF-8', 14:59:36 INFO - 'LANGUAGE': 'en_US:en', 14:59:36 INFO - 'LOGNAME': 'cltbld', 14:59:36 INFO - 'MAIL': '/var/mail/cltbld', 14:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:36 INFO - 'MOZ_NO_REMOTE': '1', 14:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:36 INFO - 'NO_EM_RESTART': '1', 14:59:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:36 INFO - 'PWD': '/builds/slave/test', 14:59:36 INFO - 'SHELL': '/bin/bash', 14:59:36 INFO - 'SHLVL': '1', 14:59:36 INFO - 'TERM': 'linux', 14:59:36 INFO - 'TMOUT': '86400', 14:59:36 INFO - 'USER': 'cltbld', 14:59:36 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', 14:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:36 INFO - '_': '/tools/buildbot/bin/python'} 14:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:59:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:59:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:59:38 INFO - Installing collected packages: mozsystemmonitor 14:59:38 INFO - Running setup.py install for mozsystemmonitor 14:59:38 INFO - Successfully installed mozsystemmonitor 14:59:38 INFO - Cleaning up... 14:59:38 INFO - Return code: 0 14:59:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:38 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 0x7ffa50d60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1613770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a29c0>, '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 0x16a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d50>, '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': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', '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 14:59:38 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 14:59:38 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 14:59:38 INFO - Using env: {'DISPLAY': ':0', 14:59:38 INFO - 'HOME': '/home/cltbld', 14:59:38 INFO - 'LANG': 'en_US.UTF-8', 14:59:38 INFO - 'LANGUAGE': 'en_US:en', 14:59:38 INFO - 'LOGNAME': 'cltbld', 14:59:38 INFO - 'MAIL': '/var/mail/cltbld', 14:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:38 INFO - 'MOZ_NO_REMOTE': '1', 14:59:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:38 INFO - 'NO_EM_RESTART': '1', 14:59:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:38 INFO - 'PWD': '/builds/slave/test', 14:59:38 INFO - 'SHELL': '/bin/bash', 14:59:38 INFO - 'SHLVL': '1', 14:59:38 INFO - 'TERM': 'linux', 14:59:38 INFO - 'TMOUT': '86400', 14:59:38 INFO - 'USER': 'cltbld', 14:59:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', 14:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:38 INFO - '_': '/tools/buildbot/bin/python'} 14:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:38 INFO - Downloading/unpacking blobuploader==1.2.4 14:59:38 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 14:59:38 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 14:59:38 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 14:59:38 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 14:59:38 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 14:59:38 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 14:59:40 INFO - Downloading blobuploader-1.2.4.tar.gz 14:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:59:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:59:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:59:41 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 14:59:41 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 14:59:41 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 14:59:41 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 14:59:41 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 14:59:41 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 14:59:41 INFO - Downloading docopt-0.6.1.tar.gz 14:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:59:41 INFO - Installing collected packages: blobuploader, requests, docopt 14:59:41 INFO - Running setup.py install for blobuploader 14:59:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:59:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:59:41 INFO - Running setup.py install for requests 14:59:41 INFO - Running setup.py install for docopt 14:59:41 INFO - Successfully installed blobuploader requests docopt 14:59:41 INFO - Cleaning up... 14:59:42 INFO - Return code: 0 14:59:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59: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')]} 14:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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')]} 14:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:42 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 0x7ffa50d60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1613770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a29c0>, '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 0x16a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d50>, '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': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', '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 14:59:42 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 14:59:42 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 14:59:42 INFO - Using env: {'DISPLAY': ':0', 14:59:42 INFO - 'HOME': '/home/cltbld', 14:59:42 INFO - 'LANG': 'en_US.UTF-8', 14:59:42 INFO - 'LANGUAGE': 'en_US:en', 14:59:42 INFO - 'LOGNAME': 'cltbld', 14:59:42 INFO - 'MAIL': '/var/mail/cltbld', 14:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:42 INFO - 'MOZ_NO_REMOTE': '1', 14:59:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:42 INFO - 'NO_EM_RESTART': '1', 14:59:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:42 INFO - 'PWD': '/builds/slave/test', 14:59:42 INFO - 'SHELL': '/bin/bash', 14:59:42 INFO - 'SHLVL': '1', 14:59:42 INFO - 'TERM': 'linux', 14:59:42 INFO - 'TMOUT': '86400', 14:59:42 INFO - 'USER': 'cltbld', 14:59:42 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', 14:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:42 INFO - '_': '/tools/buildbot/bin/python'} 14:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:59:42 INFO - Running setup.py (path:/tmp/pip-5DtbPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:59:42 INFO - Running setup.py (path:/tmp/pip-lirViX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:59:42 INFO - Running setup.py (path:/tmp/pip-yQ0DN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:59:42 INFO - Running setup.py (path:/tmp/pip-aftuoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:59:42 INFO - Running setup.py (path:/tmp/pip-YEp4cJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:59:42 INFO - Running setup.py (path:/tmp/pip-3PmUDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:59:42 INFO - Running setup.py (path:/tmp/pip-bMr_Px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:59:42 INFO - Running setup.py (path:/tmp/pip-7otcaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:59:42 INFO - Running setup.py (path:/tmp/pip-MpOEcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:59:42 INFO - Running setup.py (path:/tmp/pip-9HzfPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:59:42 INFO - Running setup.py (path:/tmp/pip-L2Ex4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:59:43 INFO - Running setup.py (path:/tmp/pip-0ti0IU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:59:43 INFO - Running setup.py (path:/tmp/pip-O7eOA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:59:43 INFO - Running setup.py (path:/tmp/pip-BSpRPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:43 INFO - Running setup.py (path:/tmp/pip-S8uWRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:59:43 INFO - Running setup.py (path:/tmp/pip-AAMnSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:59:43 INFO - Running setup.py (path:/tmp/pip-XvZVcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:59:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:59:43 INFO - Running setup.py install for manifestparser 14:59:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:59:43 INFO - Running setup.py install for mozcrash 14:59:43 INFO - Running setup.py install for mozdebug 14:59:43 INFO - Running setup.py install for mozdevice 14:59:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:59:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:59:43 INFO - Running setup.py install for mozfile 14:59:43 INFO - Running setup.py install for mozhttpd 14:59:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:59:44 INFO - Running setup.py install for mozinfo 14:59:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:59:44 INFO - Running setup.py install for mozInstall 14:59:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:59:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:59:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:59:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:59:44 INFO - Running setup.py install for mozleak 14:59:44 INFO - Running setup.py install for mozlog 14:59:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:59:44 INFO - Running setup.py install for moznetwork 14:59:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:59:44 INFO - Running setup.py install for mozprocess 14:59:44 INFO - Running setup.py install for mozprofile 14:59:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:59:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:59:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:59:44 INFO - Running setup.py install for mozrunner 14:59:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:59:44 INFO - Running setup.py install for mozscreenshot 14:59:45 INFO - Running setup.py install for moztest 14:59:45 INFO - Running setup.py install for mozversion 14:59:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:59:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:59:45 INFO - Cleaning up... 14:59:45 INFO - Return code: 0 14:59:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:45 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 0x7ffa50d60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1613770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a29c0>, '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 0x16a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d50>, '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': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', '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 14:59:45 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 14:59:45 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 14:59:45 INFO - Using env: {'DISPLAY': ':0', 14:59:45 INFO - 'HOME': '/home/cltbld', 14:59:45 INFO - 'LANG': 'en_US.UTF-8', 14:59:45 INFO - 'LANGUAGE': 'en_US:en', 14:59:45 INFO - 'LOGNAME': 'cltbld', 14:59:45 INFO - 'MAIL': '/var/mail/cltbld', 14:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:45 INFO - 'MOZ_NO_REMOTE': '1', 14:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:45 INFO - 'NO_EM_RESTART': '1', 14:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:45 INFO - 'PWD': '/builds/slave/test', 14:59:45 INFO - 'SHELL': '/bin/bash', 14:59:45 INFO - 'SHLVL': '1', 14:59:45 INFO - 'TERM': 'linux', 14:59:45 INFO - 'TMOUT': '86400', 14:59:45 INFO - 'USER': 'cltbld', 14:59:45 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', 14:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:45 INFO - '_': '/tools/buildbot/bin/python'} 14:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:59:45 INFO - Running setup.py (path:/tmp/pip-GUJNTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:59:45 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)) 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:59:45 INFO - Running setup.py (path:/tmp/pip-3bnKsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:59:45 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)) 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:59:45 INFO - Running setup.py (path:/tmp/pip-JeKGfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:59:45 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)) 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:59:45 INFO - Running setup.py (path:/tmp/pip-11xpIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:59:45 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)) 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:59:45 INFO - Running setup.py (path:/tmp/pip-9zKSXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:59:45 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)) 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:59:45 INFO - Running setup.py (path:/tmp/pip-3oi6g4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:59:45 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)) 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:59:45 INFO - Running setup.py (path:/tmp/pip-mSSFj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:59:45 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)) 14:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:59:45 INFO - Running setup.py (path:/tmp/pip-9DLkaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:59:46 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)) 14:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:59:46 INFO - Running setup.py (path:/tmp/pip-zytWFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:59:46 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)) 14:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:59:46 INFO - Running setup.py (path:/tmp/pip-0AatXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 14:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:59:46 INFO - Running setup.py (path:/tmp/pip-GAB5vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:59:46 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)) 14:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:59:46 INFO - Running setup.py (path:/tmp/pip-yzep_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:59:46 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)) 14:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:59:46 INFO - Running setup.py (path:/tmp/pip-mRBjHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:59:46 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)) 14:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:59:46 INFO - Running setup.py (path:/tmp/pip-lwrokH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:59:46 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)) 14:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:46 INFO - Running setup.py (path:/tmp/pip-IRraHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:46 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)) 14:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:59:46 INFO - Running setup.py (path:/tmp/pip-lZqGXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:59:46 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)) 14:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:59:46 INFO - Running setup.py (path:/tmp/pip-fOVYU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:59:46 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)) 14:59:46 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)) 14:59:46 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)) 14:59:46 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)) 14:59:46 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)) 14:59:46 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)) 14:59:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:59:46 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 14:59:46 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 14:59:46 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 14:59:46 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 14:59:46 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 14:59:46 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 14:59:48 INFO - Downloading blessings-1.6.tar.gz 14:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:59:48 INFO - Installing collected packages: blessings 14:59:48 INFO - Running setup.py install for blessings 14:59:48 INFO - Successfully installed blessings 14:59:48 INFO - Cleaning up... 14:59:48 INFO - Return code: 0 14:59:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:59:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:59:49 INFO - Reading from file tmpfile_stdout 14:59:49 INFO - Current package versions: 14:59:49 INFO - argparse == 1.2.1 14:59:49 INFO - blessings == 1.6 14:59:49 INFO - blobuploader == 1.2.4 14:59:49 INFO - docopt == 0.6.1 14:59:49 INFO - manifestparser == 1.1 14:59:49 INFO - mozInstall == 1.12 14:59:49 INFO - mozcrash == 0.17 14:59:49 INFO - mozdebug == 0.1 14:59:49 INFO - mozdevice == 0.48 14:59:49 INFO - mozfile == 1.2 14:59:49 INFO - mozhttpd == 0.7 14:59:49 INFO - mozinfo == 0.9 14:59:49 INFO - mozleak == 0.1 14:59:49 INFO - mozlog == 3.2 14:59:49 INFO - moznetwork == 0.27 14:59:49 INFO - mozprocess == 0.22 14:59:49 INFO - mozprofile == 0.28 14:59:49 INFO - mozrunner == 6.11 14:59:49 INFO - mozscreenshot == 0.1 14:59:49 INFO - mozsystemmonitor == 0.3 14:59:49 INFO - moztest == 0.7 14:59:49 INFO - mozversion == 1.4 14:59:49 INFO - psutil == 3.1.1 14:59:49 INFO - requests == 1.2.3 14:59:49 INFO - wsgiref == 0.1.2 14:59:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:49 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')]} 14:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:49 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')]} 14:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:49 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 0x7ffa50d60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1613770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a29c0>, '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 0x16a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d50>, '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': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', '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 14:59:49 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 14:59:49 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 14:59:49 INFO - Using env: {'DISPLAY': ':0', 14:59:49 INFO - 'HOME': '/home/cltbld', 14:59:49 INFO - 'LANG': 'en_US.UTF-8', 14:59:49 INFO - 'LANGUAGE': 'en_US:en', 14:59:49 INFO - 'LOGNAME': 'cltbld', 14:59:49 INFO - 'MAIL': '/var/mail/cltbld', 14:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:49 INFO - 'MOZ_NO_REMOTE': '1', 14:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:49 INFO - 'NO_EM_RESTART': '1', 14:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:49 INFO - 'PWD': '/builds/slave/test', 14:59:49 INFO - 'SHELL': '/bin/bash', 14:59:49 INFO - 'SHLVL': '1', 14:59:49 INFO - 'TERM': 'linux', 14:59:49 INFO - 'TMOUT': '86400', 14:59:49 INFO - 'USER': 'cltbld', 14:59:49 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', 14:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:49 INFO - '_': '/tools/buildbot/bin/python'} 14:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:49 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)) 14:59:49 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)) 14:59:49 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)) 14:59:49 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)) 14:59:49 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)) 14:59:49 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)) 14:59:49 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)) 14:59:49 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)) 14:59:49 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)) 14:59:49 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)) 14:59:49 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)) 14:59:49 INFO - Cleaning up... 14:59:49 INFO - Return code: 0 14:59:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:59:49 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')]} 14:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:49 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')]} 14:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:49 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 0x7ffa50d60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1613770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a29c0>, '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 0x16a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d50>, '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': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', '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 14:59:49 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 14:59:49 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 14:59:49 INFO - Using env: {'DISPLAY': ':0', 14:59:49 INFO - 'HOME': '/home/cltbld', 14:59:49 INFO - 'LANG': 'en_US.UTF-8', 14:59:49 INFO - 'LANGUAGE': 'en_US:en', 14:59:49 INFO - 'LOGNAME': 'cltbld', 14:59:49 INFO - 'MAIL': '/var/mail/cltbld', 14:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:49 INFO - 'MOZ_NO_REMOTE': '1', 14:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:49 INFO - 'NO_EM_RESTART': '1', 14:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:49 INFO - 'PWD': '/builds/slave/test', 14:59:49 INFO - 'SHELL': '/bin/bash', 14:59:49 INFO - 'SHLVL': '1', 14:59:49 INFO - 'TERM': 'linux', 14:59:49 INFO - 'TMOUT': '86400', 14:59:49 INFO - 'USER': 'cltbld', 14:59:49 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', 14:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:49 INFO - '_': '/tools/buildbot/bin/python'} 14:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:49 INFO - Downloading/unpacking jsonschema 14:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:59:51 INFO - Downloading/unpacking functools32 (from jsonschema) 14:59:51 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 14:59:51 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 14:59:51 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 14:59:51 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 14:59:51 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 14:59:51 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 14:59:51 INFO - Downloading functools32-3.2.3-2.tar.gz 14:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:59:51 INFO - warning: no files found matching '*.txt' 14:59:51 INFO - no previously-included directories found matching 'build' 14:59:51 INFO - no previously-included directories found matching 'dist' 14:59:51 INFO - no previously-included directories found matching '.git*' 14:59:51 INFO - Installing collected packages: jsonschema, functools32 14:59:51 INFO - Running setup.py install for functools32 14:59:51 INFO - warning: no files found matching '*.txt' 14:59:51 INFO - no previously-included directories found matching 'build' 14:59:51 INFO - no previously-included directories found matching 'dist' 14:59:51 INFO - no previously-included directories found matching '.git*' 14:59:51 INFO - Successfully installed jsonschema functools32 14:59:51 INFO - Cleaning up... 14:59:51 INFO - Return code: 0 14:59:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:59:51 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')]} 14:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:51 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')]} 14:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:51 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 0x7ffa50d60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1613770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a29c0>, '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 0x16a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d50>, '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': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', '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 14:59:51 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 14:59:51 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 14:59:51 INFO - Using env: {'DISPLAY': ':0', 14:59:51 INFO - 'HOME': '/home/cltbld', 14:59:51 INFO - 'LANG': 'en_US.UTF-8', 14:59:51 INFO - 'LANGUAGE': 'en_US:en', 14:59:51 INFO - 'LOGNAME': 'cltbld', 14:59:51 INFO - 'MAIL': '/var/mail/cltbld', 14:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:51 INFO - 'MOZ_NO_REMOTE': '1', 14:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:51 INFO - 'NO_EM_RESTART': '1', 14:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:51 INFO - 'PWD': '/builds/slave/test', 14:59:51 INFO - 'SHELL': '/bin/bash', 14:59:51 INFO - 'SHLVL': '1', 14:59:51 INFO - 'TERM': 'linux', 14:59:51 INFO - 'TMOUT': '86400', 14:59:51 INFO - 'USER': 'cltbld', 14:59:51 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', 14:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:51 INFO - '_': '/tools/buildbot/bin/python'} 14:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:52 INFO - Downloading/unpacking flake8 14:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:59:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:59:54 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 14:59:54 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 14:59:54 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 14:59:54 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 14:59:54 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 14:59:54 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 14:59:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:59:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:59:54 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 14:59:54 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 14:59:54 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 14:59:54 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 14:59:54 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 14:59:54 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 14:59:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:59:54 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 14:59:54 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 14:59:54 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 14:59:54 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 14:59:54 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 14:59:54 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 14:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:59:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:59:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:59:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:59:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:59:54 INFO - no previously-included directories found matching 'docs/_build' 14:59:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:59:54 INFO - Running setup.py install for pep8 14:59:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:59:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:59:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:59:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:59:54 INFO - no previously-included directories found matching 'docs/_build' 14:59:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:59:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:59:54 INFO - Cleaning up... 14:59:54 INFO - Return code: 0 14:59:54 INFO - Running post-action listener: _resource_record_post_action 14:59:54 INFO - Running post-action listener: _start_resource_monitoring 14:59:55 INFO - Starting resource monitoring. 14:59:55 INFO - ##### 14:59:55 INFO - ##### Finished create-virtualenv step (success) 14:59:55 INFO - ##### 14:59:55 INFO - ##### 14:59:55 INFO - ##### Running install step. 14:59:55 INFO - ##### 14:59:55 INFO - Running pre-action listener: _resource_record_pre_action 14:59:55 INFO - Running main action method: install 14:59:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:59:55 INFO - Reading from file tmpfile_stdout 14:59:55 INFO - Detecting whether we're running mozinstall >=1.0... 14:59:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:59:55 INFO - Reading from file tmpfile_stdout 14:59:55 INFO - Output received: 14:59:55 INFO - Usage: mozinstall [options] installer 14:59:55 INFO - Options: 14:59:55 INFO - -h, --help show this help message and exit 14:59:55 INFO - -d DEST, --destination=DEST 14:59:55 INFO - Directory to install application into. [default: 14:59:55 INFO - "/builds/slave/test"] 14:59:55 INFO - --app=APP Application being installed. [default: firefox] 14:59:55 INFO - mkdir: /builds/slave/test/build/application 14:59:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:00:11 INFO - Reading from file tmpfile_stdout 15:00:11 INFO - Output received: 15:00:11 INFO - /builds/slave/test/build/application/firefox/firefox 15:00:11 INFO - Running post-action listener: _resource_record_post_action 15:00:11 INFO - ##### 15:00:11 INFO - ##### Finished install step (success) 15:00:11 INFO - ##### 15:00:11 INFO - ##### 15:00:11 INFO - ##### Running run-tests step. 15:00:11 INFO - ##### 15:00:11 INFO - Running pre-action listener: _resource_record_pre_action 15:00:11 INFO - Running main action method: run_tests 15:00:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:00:11 INFO - Python 2.7.3 15:00:11 INFO - Return code: 0 15:00:11 INFO - grabbing minidump binary from tooltool 15:00:11 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')]} 15:00:11 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a29c0>, '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 0x16a38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:00:11 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 15:00:11 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 15:00:11 INFO - Calling ['/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'] with output_timeout 600 15:00:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:00:11 INFO - Return code: 0 15:00:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:00:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:00:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:00:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:00:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:00:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:00:12 INFO - Return code: 0 15:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 15:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 15:00:12 INFO - Using env: {'DISPLAY': ':0', 15:00:12 INFO - 'HOME': '/home/cltbld', 15:00:12 INFO - 'LANG': 'en_US.UTF-8', 15:00:12 INFO - 'LANGUAGE': 'en_US:en', 15:00:12 INFO - 'LOGNAME': 'cltbld', 15:00:12 INFO - 'MAIL': '/var/mail/cltbld', 15:00:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:00:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:12 INFO - 'MOZ_NO_REMOTE': '1', 15:00:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:12 INFO - 'NO_EM_RESTART': '1', 15:00:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:12 INFO - 'PWD': '/builds/slave/test', 15:00:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:00:12 INFO - 'SHELL': '/bin/bash', 15:00:12 INFO - 'SHLVL': '1', 15:00:12 INFO - 'TERM': 'linux', 15:00:12 INFO - 'TMOUT': '86400', 15:00:12 INFO - 'USER': 'cltbld', 15:00:12 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463263159.334392-127088963', 15:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:12 INFO - '_': '/tools/buildbot/bin/python'} 15:00:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 15:00:12 INFO - mozversion application_buildid: 20160514134428 15:00:12 INFO - mozversion application_changeset: c67242e935ee610b6f6a6e37596a274bc9ed2c9f 15:00:12 INFO - mozversion application_display_name: Nightly 15:00:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:00:12 INFO - mozversion application_name: Firefox 15:00:12 INFO - mozversion application_remotingname: firefox 15:00:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:00:12 INFO - mozversion application_vendor: Mozilla 15:00:12 INFO - mozversion application_version: 49.0a1 15:00:12 INFO - mozversion platform_buildid: 20160514134428 15:00:12 INFO - mozversion platform_changeset: c67242e935ee610b6f6a6e37596a274bc9ed2c9f 15:00:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:00:12 INFO - mozversion platform_version: 49.0a1 15:00:12 INFO - using testdate: 1463263212 15:00:12 INFO - actual date: 1463263212 15:00:12 INFO - starting webserver on 'localhost:58786' 15:00:12 INFO - SUITE-START | Running 2 tests 15:00:12 INFO - TEST-START | dromaeo_css 15:00:12 INFO - operating with platform_type : linux_ 15:00:12 INFO - Initialising browser for dromaeo_css test... 15:00:12 INFO - TEST-INFO | started process 21961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpORMjLd/profile http://localhost:58786/getInfo.html) 15:00:16 INFO - PROCESS | 21961 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 15:00:16 INFO - PROCESS | 21961 | 15:00:16 INFO - PROCESS | 21961 | (process:22029): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:00:17 INFO - PROCESS | 21961 | __metrics Screen width/height:1600/1200 15:00:17 INFO - PROCESS | 21961 | colorDepth:24 15:00:17 INFO - PROCESS | 21961 | Browser inner width/height: 1024/697 15:00:17 INFO - PROCESS | 21961 | __metrics 15:00:18 ERROR - PROCESS | 21961 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 15:00:19 INFO - TEST-INFO | 21961: exit 0 15:00:19 INFO - Browser initialized. 15:00:19 INFO - Running cycle 1/1 for dromaeo_css test... 15:00:19 INFO - TEST-INFO | started process 22080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpORMjLd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:00:21 INFO - PROCESS | 22080 | 15:00:21 INFO - PROCESS | 22080 | (process:22141): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:00:31 INFO - PROCESS | 22080 | RSS: Main: 164663296 15:00:31 INFO - PROCESS | 22080 | 15:01:20 INFO - PROCESS | 22080 | 1463263280791 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] 15:03:33 INFO - PROCESS | 22080 | Cycle 1(1): loaded http://localhost:58786/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58786/tests/dromaeo/cssquery-ext.html) 15:03:34 INFO - PROCESS | 22080 | RSS: Main: 166498304 15:03:34 INFO - PROCESS | 22080 | 15:06:36 INFO - PROCESS | 22080 | Cycle 1(1): loaded http://localhost:58786/tests/dromaeo/cssquery-ext.html (next: http://localhost:58786/tests/dromaeo/cssquery-jquery.html) 15:06:37 INFO - PROCESS | 22080 | RSS: Main: 167723008 15:06:37 INFO - PROCESS | 22080 | 15:09:39 INFO - PROCESS | 22080 | Cycle 1(1): loaded http://localhost:58786/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58786/tests/dromaeo/cssquery-mootools.html) 15:09:40 INFO - PROCESS | 22080 | RSS: Main: 167919616 15:09:40 INFO - PROCESS | 22080 | 15:12:41 INFO - PROCESS | 22080 | Cycle 1(1): loaded http://localhost:58786/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58786/tests/dromaeo/cssquery-prototype.html) 15:12:42 INFO - PROCESS | 22080 | RSS: Main: 166088704 15:12:42 INFO - PROCESS | 22080 | 15:15:45 INFO - PROCESS | 22080 | Cycle 1(1): loaded http://localhost:58786/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58786/tests/dromaeo/cssquery-yui.html) 15:15:46 INFO - PROCESS | 22080 | RSS: Main: 167079936 15:15:46 INFO - PROCESS | 22080 | 15:18:48 INFO - PROCESS | 22080 | Cycle 1(1): loaded http://localhost:58786/tests/dromaeo/cssquery-yui.html (next: http://localhost:58786/tests/dromaeo/cssquery-dojo.html) 15:18:48 INFO - PROCESS | 22080 | RSS: Main: 169803776 15:18:48 INFO - PROCESS | 22080 | 15:18:48 INFO - PROCESS | 22080 | __start_tp_report 15:18:48 INFO - PROCESS | 22080 | _x_x_mozilla_page_load 15:18:48 INFO - PROCESS | 22080 | _x_x_mozilla_page_load_details 15:18:48 INFO - PROCESS | 22080 | |i|pagename|runs| 15:18:48 INFO - PROCESS | 22080 | |0;dojo.html;2712.416830381468;2758.6827514835786;2768.6539182602173;2771.0439898235104;2771.847548384838;4802.639802014845;4879.658423910323;4935.555799978001;4947;4997.350344455225;4806.3030860525205;4849.321095046696;4871.5615594596475;4911.435184953732;4929.260610908356;4452.109578084396;4485.730856148625;4558.156741002908;4573.5197804230575;4596.816127354902;4541.023679908819;4591.517890621487;4635.605973492257;4665.3235280884255;4692.178868697982;4433.002574420761;4551.635869130461;4624.583787459145;4628.768561571925;4701.529847015306;4569.086182763461;4572.908541829145;4580.725156490621;4614.746188959606;4617.307403889444;4553.817847286105;4554.954450455486;4561.315802629599;4571.634269258485;4602.631789456836;4683.812647494096;4759.714417134983;4782.880427989328;4819.734914579697;4823.493533179001;5149.0731668299695;5163.7159956202395;5196.090684130299;5220.216967454874;5226.491284183575;5250;5253.658512196695;5260.789568417259;5301.7084060376665;5312.9734351328;4920.384951881015;4949.381327334083;4960.578350840146;4965.90068198634;4967.503249675004;5380.5630520728655;5423;5435.891282174334;5440.265564148789;5490.505854473116;5072.492750724898;5213;5215.687058776485;5225.399079105951;5228.764705588258;5298.788048478094;5331.786728530893;5337.893242135213;5369.677819330853;5398.460153984649;5241.213817927342;5277.340332458442;5284.180951952453;5287.656302340412;5331.520163185254;5054.4692807254705;5090.9236361454605;5202.297689811902;5255.500727430888;5279.788808447619;4319.719218250803;4421.314696222091;4422.270325396338;4454.643628509712;4476.400555691109;3883.3204189266767;3897.668698160688;3899.805009749501;3926.1362500249897;3973.5033120859894;4547.136044151667;4637.721736695809;4653.2554791233915;4660.231061874752;4707.082118986833;5264.31563896691;5292.470752924677;5311.814086506954;5320.574354051667;5363.651362661414;4600.72395656255;4614.7000444971645;4622.329762184464;4644.419447569054;4654.650901182425;4640.095181439587;4723.7874295656775;4735.976320118378;4744.074905393484;4783.473817880031;4902.1911384621135;4924.4583095859425;4941.678790878582;4957.553820156059;4958.206686930218;5274.868128296824;5276.947230527646;5280.920786188133;5295.555444704913;5338.706371149624;4893.363862697826;4979.4024717032735;4983.25251212321;4983.3023376728015;5028.597712182944;5222.503862133243;5278.234655974786;5302.045631786161;5307.363116426053;5341.5459685927135;5335.38643056038;5364.892702145858;5366.034113859387;5374.193870919394;5446.291982042309;4970.801167953241;5084.618653600921;5103.209002604603;5182.689038657692;5217.113090774502;5103.055934652101;5126.641135120655;5155.200943853709;5162.354705661793;5201.453847346125;5041.873953151201;5055.216441451581;5081.339425874613;5089.720065396439;5159.355080614923;4999.675021123615;5201.92197117036;5230.34620672416;5261.36863576358;5275.525202731773;4910.582600479;5057.747112644427;5080.339555857715;5087.847364579068;5122.180451127951 15:18:48 INFO - PROCESS | 22080 | |1;ext.html;545.9945400545996;596.3946594206881;601.2934801608111;611.1199872184054;629.8047605242378;39927.60072399275;40950.59049409505;40987;41016.58983410165;41153.38269925946;40921;41680.58319416805;41715.37426938598;41763.16473670525;41793;7937.365010799137;8043.436959412844;8056.39577031722;8059.395545334094;8061.879071813927;7798;7945.483543569679;7990.560519171443;8041.155678653745;8070.112287648383;8009.879851802228;8025.879611805827;8032.678692852279;8060.3954703397185;8068.7175948841805;8031.95984020082;8041.798955026142;8058.274755271995;8059.597020148969;8078.232567906099;7989.201079891965;8021.398395120331;8022.839543209103;8056.959715201387;8063.1130575636635;32707.18232044194;38351.80824095861;38396.23207535862;38777.61222387768;38896.611033889865;3200.9199770005703;3289.5723555937816;3323.3353329333986;3393.7115345195443;3396.6603339666085;27972.300692482648;28538;28927.132186034454;29535.70464295351;29542.409151816842;3455.8963231103107;3470.6182319944787;3511.3855075361967;3515.5781306243157;3643.2895585360866;235199;235306;236261.81869090715;236626;236876;33877.32245355079;34090.31819363599;34452;35372.29255414929;35741.46387804185;36727.632723672956;37128.62871371306;37437.251254975294;37497;37528.24943501169;14660.120392776467;14912.254387280593;14920.850791491946;14923.70152596942;14938.103713777207;12262.81605775914;12285.877141228651;12314.568990085305;12389.256644601353;12400.13199076056;8507.404481686222;8518.403711740242;8553.82892342162;8610.741677749678;8664.176903194186;3262.1029216965526;3306.2560923791953;3341.548890899697;3385.830708464567;3398.5242066110764;969;983.9458829764432;1037.7094413564064;1043.5773511727762;1046.6493724602192;29360.412791744046;29403;29882;30051.248718781768;30132.246693832392;1039.2465462539749;1066.2962444786403;1068.8450174724621;1085.3216739537788;1090.7491277006334;15440.768388474182;15911.363545458284;16041.598960026093;16135.273912673958;16152.35390584387;393514.032429836;394117;395059;398848;399180;50834;50851.74574127106;51541;51743;51759;1278.341654048166;1296.4230917241925;1297.3383574377135;1324.9933750331186;1329.534662868008;27688.861555692092;29173.41653166967;29308.85345573344;29379.265518362212;29657;45429.77285113553;48842.75578622084;51039.74480127576;51154;56064;363059;366269;368494;370739;372603;40688.38967415432;40839.18321633491;41315;41400.1719965605;41500.79249603733;44742;44871;44931.55068449274;45347.54652453433;45359.7732011351;38128.26163742309;38892.2221555573;39473.60526394814;40177.39733903935;40231;38098.18987107581;38619.42070868883;39297;39736.403953940135;40135.1972960545;32856.34287314288;37709;37925.62074379331;38468.807655961544;38695;33185;33493.33013339671;35100.297994040484;35365.46951795777;37932;26399.868000659873;26926;27072.458550829266;27094;27257.591136132578 15:18:48 INFO - PROCESS | 22080 | |2;jquery.html;382.6192938026662;383.4593223554787;386.57669851512594;396.298551563732;399.75015615240477;15378.307976141072;17359.82640173598;18054.45836624902;18088.819111808876;18139.093045347712;16763.497095087136;16810.579735506617;17518.386856460027;17822.554436139104;17955;4875.366202393693;4998.050370429625;5026.195808670614;5043.924341134886;5046.318746969149;3675.246574452244;5687.800926967557;6009.038553831388;6023.18686977259;6083.422074902899;5176.637635365526;6052;6055.303640081381;6075.665838378887;6079.483243924272;5428.375736790261;5527.198556209327;5552.4169962154;5552.86117847053;5570.136628822519;5156.355455568054;5503.3120859892515;5507.669539827623;5544.223808666749;5549.19536667185;12650.683732906751;12798.48806047757;12923.612291631267;18435.446936591925;19813.60372792536;1892.4417296897448;1910.866239363245;1951.7853036166011;2064.6283668939586;2101.9941483678335;9210.631574737003;9240.26077913772;9262.814743705088;9626.229901607925;9871.40771553709;1738.869734672473;1739.8434140927377;1771.5659663382553;1771.7342398640178;1818.7453756474104;71643.91396245183;74463.62768186179;74509;74988.62505687491;76249;9780.951095244478;10175.949120254352;10260.794784104277;10413.9479302603;10438.37369757817;14328.49850255257;14452.855471445362;14474.927625362016;14487.20320382368;14532.564023079325;7454.701811927463;7546.811329716801;7575.106223444139;7628.199039100926;7642.235776422313;7148.821279468055;7156.463265255023;7219.783406497813;7233.8553228935125;7374.668139933716;4355.455568053993;4388.078503514298;4414.55854414556;4442.42248507692;4503.549645035536;1723.3106757297182;1744.4243399678076;1850.981490185081;1888.1125870840683;1914.8276655101108;793.3217099379947;833.2251006563954;853.2747164909777;882.188386684252;905.7373361725026;16144.192790360436;16649.750253746202;17085.914570427067;17192.656146876994;17236.913815430842;909.1045320359441;910.9180173784391;920.3235621817959;980.8038392321564;1007.4861820471613;8147.592620368958;9718.562664680107;9749.805003899883;9761.170300524534;9957.651482198233;380916;381293;391588;395146;395812;79002;80849.59575202086;81247.50019998386;81263;81901;932.2774849491562;978.7944531648291;985.2952897106929;990.7615480649189;992.7468495533593;16184.514464566082;16215.35138594443;16246.431374902295;16710.663146947973;16745.497635070966;37106.628933710315;37369;38001.42997854979;39105;39649.2070158601;54018;54562.727186363816;55317;55935;56027.43972560222;7829.099653539915;7877.369810415267;7953.642086106023;7966.800829979297;8038.517688938682;9885.258605604464;11773.470193841127;11939.940300298444;12057.492813398325;12111.757764844477;9979.20166386702;10133.64532241368;10140.49297535135;10384.480775961021;10614.787704245717;10258.948705256425;10263.23025773055;10351.43067131315;10474.476276186313;10687.358758474516;5838.883222335445;10191.439470828878;10450.68647940563;10504.789904202025;10696.716394032766;7625.847483050419;7716.729914452967;7799.49303295284;7940.761777146695;7983.640736167003;8477.448965817202;9921.950390248003;9938.652147174815;9964.451955142536;10049.447280399649 15:18:48 INFO - PROCESS | 22080 | |3;mootools.html;1540.9537713868585;1583.0976343484215;1747.9563010924726;1910.3791267837955;1915.9521011974691;7363.6318184090715;8007.359411247101;8112;8565.914340856589;8593.226609605133;8114.066882308536;8332.250097491225;8414.116517765638;8442.282405995498;8452.746417607466;2273.113485740558;2289.7595752446005;2312.387217387394;2317;2329.37106981115;2134.4877229464896;2202.427368884086;2309.0763694522243;2326.8371214015024;2328.441174118208;2279.87460689662;2280.395695140781;2287.5653625811124;2331.2889568681544;2346.741858395575;2219.1456289328644;2254.3913143451177;2264.9660255096187;2267.353804165805;2268.7504374518708;2211.1929145861804;2235.68700381945;2237.2281562860785;2242.529068895534;2248.2468373095035;8356.164383561596;8396.412251142423;8445.662173513052;8455.239028487404;8469;4832.637552183565;4928.950710492885;4948;4971.37857767779;4996.25056241563;2975.345424006715;3003.8648260828095;3199.63204231514;3205;3217.436948533997;955.159459675488;955.6702937486556;961.1349785193312;978.774881777188;989.2432289298692;11636.941815291038;11647.6505704829;11666.300021998622;11698.94150529242;11728.648140555712;4338.197433474817;4373.759443230653;4386.583274588909;4457.064016556559;4459.44256967879;9815.214782817358;9832.852507212398;9845.655402060893;9900.702978910644;9953.701388958198;4934.1118598651865;5004.949950500449;5007.248912663057;5012.674176178537;5052.8484145475695;3962.5244970603135;4308.74147551148;4448.399466072039;4541.091781643684;4566.13243483737;3876.573576906538;3915.7454765440157;4031.697622678311;4092.01791570027;4116.341385378325;1240.8076748104058;1281;1290.7224946636518;1298.2859427314938;1301.3168086754529;850.4132148817296;860.2945584620676;877.9736607901773;914.1178762494225;931.0642803981955;5455.863603409946;5514.724263786795;5528.695921724263;5608.298962629671;5747.540196784247;896.7758060484879;910.6220918318955;923.1645360948219;952.1620973543238;993.4933184076173;3836.0793409582056;3852.2488114817343;3853.537575490959;3874.1283211277237;3934.1934903344745;9759.9024009759;10104.494775261208;10139.239557033252;10166.949165254126;10179.796404071878;10036.197104231644;10058.145057670034;10062.24533160016;10063.094321511098;10077.748056298504;7123.180834204133;7180.246074162243;7210.783676489714;7231.204567497571;7236.710531578783;5388.326459192601;5399.83800485986;5462.317210348707;5471.5896307777875;5664.461876121762;8939;9221.953890230507;9277.072292770668;9446.905530944603;9483.810323793623;9390.295727820578;9500.42997420157;9563.330566860253;9618.230541556519;9687.806243875224;7874.763757087297;7983.081945576101;7983.441159119038;8029.237222463857;8044.6379912902885;7905.920940790518;7932.325752310888;7941.444098913252;7943;8100.189981001853;7007.789766307019;7223.1693355264815;7255.383292420203;7267.273272672902;7357.963210183915;7122.7507037253445;7280.453965952469;7287.817804554928;7314.158871729819;7432.516886402366;6876.071730316543;6946.548474349152;6972.058772065706;7046.823829404306;7046.823829404306;4701.670883038291;4803.18345881208;4873.95126048735;4914.92627610579;5051.747412629427;4795.352627395257;4926.433460152129;4959.256111583291;5032.245163225545;5066.847994560169 15:18:48 INFO - PROCESS | 22080 | |4;prototype.html;315.34723123135103;320.37047202247584;320.5384246684774;324.8456982933107;324.9382617302714;5019.723915184668;5062.190049592066;5074.107758577612;5074.670146440479;5089.7679973217;4994.97502512487;5007.899842003158;5016.247562865572;5018.899622007567;5072.416672082712;3861.903452413684;3894.6689531389866;3929.0766669832565;3934.8229329680235;3958.2083583283315;3943.2704949584418;3952.584978577251;3970.642642162219;3977.125032492847;3995.4805875236325;3939.6848252139903;3948.4669569608022;3957.76253424794;3968.2063587282514;3971.3844354125013;3781.640744129303;3923.3914095221107;3938.7439816411843;3967.821448034845;3979.721419500622;3486.721062315034;3500.387432199355;3501.28223714138;3505.737069719781;3518.7888726676483;4729.290606409032;4737.194676904935;4743.525647435264;4751.85955370712;4759.714417134983;4342.413774140482;4444.644428445717;4488.798004089824;4508.549145085498;4515.729056256602;5141.30592370029;5179.559737422323;5188.11801993662;5211.557017653504;5216.295800067019;3825.6365645263654;3832.1569254764186;3840.906705845293;3853.497136116917;3870.909708757296;5462.918056229159;5495.313085864267;5516.834494965117;5526.982651332275;5532.0488163094205;3673.8897833065053;3878.941815872764;3882.320593896057;3884.3590807516443;3900.64894159527;3918.294706952719;3955.723099383016;3956.802159891994;3970.900727481836;3981.900452488653;4497.572730590588;4505.481869584974;4508.81964721414;4509.481409637868;4548.636109111263;5108.795648174106;5362.222477740784;5368.32895888014;5374.220737992969;5374.27447294618;1373.5192682561024;1382.315753701924;1383;1388.8403183342023;1390.9513167039106;845.5307304445969;865.8528050231475;876.4784952952983;878.493383846706;893.8614514750224;4584.968382114064;4747.572718455355;4755.904881902343;4818.6626936114135;4823.324734537167;5497.367802702661;5526.861828454241;5540.252065971123;5547.889042219133;5579.525740312119;4471.888202794891;4708.293755936637;4732.810687572527;4761.52384761528;4778.474367819537;2911.3696330054813;2959.8816047358296;2967.1840243933093;2968.554716792455;2973.747231485305;5236;5257.845292824351;5266.1574148136115;5270.183121616155;5298.178782288752;5391.838244852583;5675.2054712340305;5689.77240910359;5701.372848986608;5702.830919661459;5244.632875698664;5246.685198888079;5247.580193584427;5269.104252277199;5272.762725677354;5592.804251851166;5607.775688972559;5620.044592419216;5620.943790562042;5636.957162924872;5165.845024649267;5383.246345511553;5423.7830486780085;5458.707342915905;5496.450354964471;5209.984053109607;5249.763760630704;5257.684538927677;5261;5262.526372626482;3869.941950870683;3909.452676625218;3926.489556357655;3930.744501607386;3933.370660694275;5247.317848679647;5502.266785962409;5574.275344205227;5587.245721827501;5591.18927755465;5393.325834270716;5404.378496472956;5404.8108316208745;5405.891702236052;5418.864528386822;5127.4103478099005;5276.736163191902;5351.892962140813;5352.090144675492;5365.758540865592;5251.291075704731;5263.421023687315;5264.921026184534;5307.256984022317;5311.521963023347;5150.896982060262;5211.244369566316;5392.541633961;5403.378611459732;5425.891482170414;5230.110881150137;5253.054450199001;5286.286351342674;5304.867378315573;5319.893602127859 15:18:48 INFO - PROCESS | 22080 | |5;yui.html;753.1715113375286;816.816216351321;817.1052697296458;828.5318794880893;828.7886588919824;11744.295342279458;12762.361881905914;12766.744665106693;12770.233785972836;12789.808152877702;11575.594854180106;11619.186656934018;11641.592544260953;11647;11675.474603642835;668.6489592963709;857.5412154497345;875.9868601970976;891.3092353426082;892.7768057985504;869.0744357259498;874.2961915657893;875.4878396138234;876.7895705030778;876.9693060742875;922.0088404964656;924.2513564013137;924.8936372317169;925.8981512033705;928.8281667891462;921.6543796076471;925.051821882569;925.1442415765424;926.8980412154658;929.1823195587907;682.7917485167022;685.859398823245;687.1925487552106;687.7936619014275;690.0408432279136;12550.874491255061;12566.560170394083;12590.622281331574;12592.307423091726;12608.306543140123;12872.613821585368;12980.870191298061;13048.34758262083;13198.142120762215;13256;10473.738156546071;10535.420551869644;10581.576736930514;10636.149108071335;10824.18818588609;3334.4664853623303;3366.6969972702327;3385.9661403386144;3410.4202285611505;3422.0076177908627;50004.249936250984;50478.7476062621;51827.481725182646;51892.96214075735;51950.48049519494;9503.619855205714;9886.653967111117;10153.393737084602;10191.474687532544;10607.94696026515;19539.316123935594;19680.114394852266;20084.19663213455;20112.798872011386;20131.79868201299;6886.586804791728;7090.503664743418;7137.2149063602965;7171.677274522659;7304.963475182696;3807.638274363931;3991.1219531702977;3992.760434373889;4037.253108174997;4052.4124002019544;3040.650325212629;3137.074563003919;3140.979181765935;3144.622645282581;3169.904902852918;517.5368045599167;538.7360193505154;549.9175123731472;553.8255449533384;554.9972250138724;585.8652509922656;610.4963405190736;639.9456046236029;640.8654182621608;642.645391058673;8028.357731381476;8035.55804430762;8122.715704950417;8345.628645271092;8382.287505561973;562.7270773674765;600.9579329446897;630.4609558827136;642.4824088117612;662.6752891083335;4066.6543343815515;4082.1631565528996;4177.624013838769;4194.0563373240775;4194.412782210493;58498.41501585015;59359.40640593625;59985.700071500236;60071.69964150239;60684.393156068756;50391.49608503941;50856.49143508592;51319.48680513222;53078;53363.46636533585;19365.709514357015;19470.80529194718;21399.89300053521;46812.53187468082;47076.293855592194;7582.507137036075;7741.961290193513;7760.860008792038;7761.9611901940125;7908.288254057163;31828.840855795574;32428;32640.34719305648;32646.83676581602;33211.50182747309;39464.80267598644;41963.580364195965;43220.56779432166;43320.56679433165;43606;10579;10791.838122428328;10805.405702686428;10889.727756806144;10900.400477973788;10682.412467314372;10987.340759554452;11308.151888608223;11527.942360288145;12006.699832504257;10343.37939723619;10404.271700980858;10483.266171367932;10640.148788097089;10828.783424331312;9739.026097390488;10048.69853904384;10111.898881011095;10487.37075775456;10857.239993200401;9612.951935240279;9727.07592778685;9753.707388778348;10330.431826249629;10334.379937203792;9237.983821779733;9269.907300926905;9353.579088940878;9379.343445958717;9545.570449329936;8726.476411415335;9292.256619470561;9418.152366287068;9421.5396613525;9543.379680320757 15:18:48 INFO - PROCESS | 22080 | __end_tp_report 15:18:48 INFO - PROCESS | 22080 | __start_cc_report 15:18:48 INFO - PROCESS | 22080 | _x_x_mozilla_cycle_collect,402 15:18:48 INFO - PROCESS | 22080 | __end_cc_report 15:18:48 INFO - PROCESS | 22080 | __startTimestamp1463264328804__endTimestamp 15:18:48 INFO - PROCESS | 22080 | 15:18:48 INFO - PROCESS | 22080 | ------- Summary: start ------- 15:18:48 INFO - PROCESS | 22080 | Number of tests: 6 15:18:48 INFO - PROCESS | 22080 | 15:18:48 INFO - PROCESS | 22080 | [#0] dojo.html Cycles:165 Average:4884.21 Median:4979.40 stddev:510.68 (10.3%) stddev-sans-first:482.99 15:18:48 INFO - PROCESS | 22080 | Values: 2712.4 2758.7 2768.7 2771.0 2771.8 4802.6 4879.7 4935.6 4947.0 4997.4 4806.3 4849.3 4871.6 4911.4 4929.3 4452.1 4485.7 4558.2 4573.5 4596.8 4541.0 4591.5 4635.6 4665.3 4692.2 4433.0 4551.6 4624.6 4628.8 4701.5 4569.1 4572.9 4580.7 4614.7 4617.3 4553.8 4555.0 4561.3 4571.6 4602.6 4683.8 4759.7 4782.9 4819.7 4823.5 5149.1 5163.7 5196.1 5220.2 5226.5 5250.0 5253.7 5260.8 5301.7 5313.0 4920.4 4949.4 4960.6 4965.9 4967.5 5380.6 5423.0 5435.9 5440.3 5490.5 5072.5 5213.0 5215.7 5225.4 5228.8 5298.8 5331.8 5337.9 5369.7 5398.5 5241.2 5277.3 5284.2 5287.7 5331.5 5054.5 5090.9 5202.3 5255.5 5279.8 4319.7 4421.3 4422.3 4454.6 4476.4 3883.3 3897.7 3899.8 3926.1 3973.5 4547.1 4637.7 4653.3 4660.2 4707.1 5264.3 5292.5 5311.8 5320.6 5363.7 4600.7 4614.7 4622.3 4644.4 4654.7 4640.1 4723.8 4736.0 4744.1 4783.5 4902.2 4924.5 4941.7 4957.6 4958.2 5274.9 5276.9 5280.9 5295.6 5338.7 4893.4 4979.4 4983.3 4983.3 5028.6 5222.5 5278.2 5302.0 5307.4 5341.5 5335.4 5364.9 5366.0 5374.2 5446.3 4970.8 5084.6 5103.2 5182.7 5217.1 5103.1 5126.6 5155.2 5162.4 5201.5 5041.9 5055.2 5081.3 5089.7 5159.4 4999.7 5201.9 5230.3 5261.4 5275.5 4910.6 5057.7 5080.3 5087.8 5122.2 15:18:48 INFO - PROCESS | 22080 | 15:18:48 INFO - PROCESS | 22080 | [#1] ext.html Cycles:180 Average:48656.24 Median:37928.81 stddev:89910.85 (237.1%) stddev-sans-first:90090.51 15:18:48 INFO - PROCESS | 22080 | Values: 546.0 596.4 601.3 611.1 629.8 39927.6 40950.6 40987.0 41016.6 41153.4 40921.0 41680.6 41715.4 41763.2 41793.0 7937.4 8043.4 8056.4 8059.4 8061.9 7798.0 7945.5 7990.6 8041.2 8070.1 8009.9 8025.9 8032.7 8060.4 8068.7 8032.0 8041.8 8058.3 8059.6 8078.2 7989.2 8021.4 8022.8 8057.0 8063.1 32707.2 38351.8 38396.2 38777.6 38896.6 3200.9 3289.6 3323.3 3393.7 3396.7 27972.3 28538.0 28927.1 29535.7 29542.4 3455.9 3470.6 3511.4 3515.6 3643.3 235199.0 235306.0 236261.8 236626.0 236876.0 33877.3 34090.3 34452.0 35372.3 35741.5 36727.6 37128.6 37437.3 37497.0 37528.2 14660.1 14912.3 14920.9 14923.7 14938.1 12262.8 12285.9 12314.6 12389.3 12400.1 8507.4 8518.4 8553.8 8610.7 8664.2 3262.1 3306.3 3341.5 3385.8 3398.5 969.0 983.9 1037.7 1043.6 1046.6 29360.4 29403.0 29882.0 30051.2 30132.2 1039.2 1066.3 1068.8 1085.3 1090.7 15440.8 15911.4 16041.6 16135.3 16152.4 393514.0 394117.0 395059.0 398848.0 399180.0 50834.0 50851.7 51541.0 51743.0 51759.0 1278.3 1296.4 1297.3 1325.0 1329.5 27688.9 29173.4 29308.9 29379.3 29657.0 45429.8 48842.8 51039.7 51154.0 56064.0 363059.0 366269.0 368494.0 370739.0 372603.0 40688.4 40839.2 41315.0 41400.2 41500.8 44742.0 44871.0 44931.6 45347.5 45359.8 38128.3 38892.2 39473.6 40177.4 40231.0 38098.2 38619.4 39297.0 39736.4 40135.2 32856.3 37709.0 37925.6 38468.8 38695.0 33185.0 33493.3 35100.3 35365.5 37932.0 26399.9 26926.0 27072.5 27094.0 27257.6 15:18:48 INFO - PROCESS | 22080 | 15:18:48 INFO - PROCESS | 22080 | [#2] jquery.html Cycles:180 Average:24639.98 Median:5012.12 stddev:64491.99 (1286.7%) stddev-sans-first:64647.19 15:18:48 INFO - PROCESS | 22080 | Values: 382.6 383.5 386.6 396.3 399.8 15378.3 17359.8 18054.5 18088.8 18139.1 16763.5 16810.6 17518.4 17822.6 17955.0 4875.4 4998.1 5026.2 5043.9 5046.3 3675.2 5687.8 6009.0 6023.2 6083.4 5176.6 6052.0 6055.3 6075.7 6079.5 5428.4 5527.2 5552.4 5552.9 5570.1 5156.4 5503.3 5507.7 5544.2 5549.2 12650.7 12798.5 12923.6 18435.4 19813.6 1892.4 1910.9 1951.8 2064.6 2102.0 9210.6 9240.3 9262.8 9626.2 9871.4 1738.9 1739.8 1771.6 1771.7 1818.7 71643.9 74463.6 74509.0 74988.6 76249.0 9781.0 10175.9 10260.8 10413.9 10438.4 14328.5 14452.9 14474.9 14487.2 14532.6 7454.7 7546.8 7575.1 7628.2 7642.2 7148.8 7156.5 7219.8 7233.9 7374.7 4355.5 4388.1 4414.6 4442.4 4503.5 1723.3 1744.4 1851.0 1888.1 1914.8 793.3 833.2 853.3 882.2 905.7 16144.2 16649.8 17085.9 17192.7 17236.9 909.1 910.9 920.3 980.8 1007.5 8147.6 9718.6 9749.8 9761.2 9957.7 380916.0 381293.0 391588.0 395146.0 395812.0 79002.0 80849.6 81247.5 81263.0 81901.0 932.3 978.8 985.3 990.8 992.7 16184.5 16215.4 16246.4 16710.7 16745.5 37106.6 37369.0 38001.4 39105.0 39649.2 54018.0 54562.7 55317.0 55935.0 56027.4 7829.1 7877.4 7953.6 7966.8 8038.5 9885.3 11773.5 11939.9 12057.5 12111.8 9979.2 10133.6 10140.5 10384.5 10614.8 10258.9 10263.2 10351.4 10474.5 10687.4 5838.9 10191.4 10450.7 10504.8 10696.7 7625.8 7716.7 7799.5 7940.8 7983.6 8477.4 9922.0 9938.7 9964.5 10049.4 15:18:48 INFO - PROCESS | 22080 | 15:18:48 INFO - PROCESS | 22080 | [#3] mootools.html Cycles:180 Average:5494.01 Median:5042.00 stddev:3073.16 (61.0%) stddev-sans-first:3067.43 15:18:48 INFO - PROCESS | 22080 | Values: 1541.0 1583.1 1748.0 1910.4 1916.0 7363.6 8007.4 8112.0 8565.9 8593.2 8114.1 8332.3 8414.1 8442.3 8452.7 2273.1 2289.8 2312.4 2317.0 2329.4 2134.5 2202.4 2309.1 2326.8 2328.4 2279.9 2280.4 2287.6 2331.3 2346.7 2219.1 2254.4 2265.0 2267.4 2268.8 2211.2 2235.7 2237.2 2242.5 2248.2 8356.2 8396.4 8445.7 8455.2 8469.0 4832.6 4929.0 4948.0 4971.4 4996.3 2975.3 3003.9 3199.6 3205.0 3217.4 955.2 955.7 961.1 978.8 989.2 11636.9 11647.7 11666.3 11698.9 11728.6 4338.2 4373.8 4386.6 4457.1 4459.4 9815.2 9832.9 9845.7 9900.7 9953.7 4934.1 5004.9 5007.2 5012.7 5052.8 3962.5 4308.7 4448.4 4541.1 4566.1 3876.6 3915.7 4031.7 4092.0 4116.3 1240.8 1281.0 1290.7 1298.3 1301.3 850.4 860.3 878.0 914.1 931.1 5455.9 5514.7 5528.7 5608.3 5747.5 896.8 910.6 923.2 952.2 993.5 3836.1 3852.2 3853.5 3874.1 3934.2 9759.9 10104.5 10139.2 10166.9 10179.8 10036.2 10058.1 10062.2 10063.1 10077.7 7123.2 7180.2 7210.8 7231.2 7236.7 5388.3 5399.8 5462.3 5471.6 5664.5 8939.0 9222.0 9277.1 9446.9 9483.8 9390.3 9500.4 9563.3 9618.2 9687.8 7874.8 7983.1 7983.4 8029.2 8044.6 7905.9 7932.3 7941.4 7943.0 8100.2 7007.8 7223.2 7255.4 7267.3 7358.0 7122.8 7280.5 7287.8 7314.2 7432.5 6876.1 6946.5 6972.1 7046.8 7046.8 4701.7 4803.2 4874.0 4914.9 5051.7 4795.4 4926.4 4959.3 5032.2 5066.8 15:18:48 INFO - PROCESS | 22080 | 15:18:48 INFO - PROCESS | 22080 | [#4] prototype.html Cycles:180 Average:4434.02 Median:5067.30 stddev:1292.24 (25.5%) stddev-sans-first:1258.34 15:18:48 INFO - PROCESS | 22080 | Values: 315.3 320.4 320.5 324.8 324.9 5019.7 5062.2 5074.1 5074.7 5089.8 4995.0 5007.9 5016.2 5018.9 5072.4 3861.9 3894.7 3929.1 3934.8 3958.2 3943.3 3952.6 3970.6 3977.1 3995.5 3939.7 3948.5 3957.8 3968.2 3971.4 3781.6 3923.4 3938.7 3967.8 3979.7 3486.7 3500.4 3501.3 3505.7 3518.8 4729.3 4737.2 4743.5 4751.9 4759.7 4342.4 4444.6 4488.8 4508.5 4515.7 5141.3 5179.6 5188.1 5211.6 5216.3 3825.6 3832.2 3840.9 3853.5 3870.9 5462.9 5495.3 5516.8 5527.0 5532.0 3673.9 3878.9 3882.3 3884.4 3900.6 3918.3 3955.7 3956.8 3970.9 3981.9 4497.6 4505.5 4508.8 4509.5 4548.6 5108.8 5362.2 5368.3 5374.2 5374.3 1373.5 1382.3 1383.0 1388.8 1391.0 845.5 865.9 876.5 878.5 893.9 4585.0 4747.6 4755.9 4818.7 4823.3 5497.4 5526.9 5540.3 5547.9 5579.5 4471.9 4708.3 4732.8 4761.5 4778.5 2911.4 2959.9 2967.2 2968.6 2973.7 5236.0 5257.8 5266.2 5270.2 5298.2 5391.8 5675.2 5689.8 5701.4 5702.8 5244.6 5246.7 5247.6 5269.1 5272.8 5592.8 5607.8 5620.0 5620.9 5637.0 5165.8 5383.2 5423.8 5458.7 5496.5 5210.0 5249.8 5257.7 5261.0 5262.5 3869.9 3909.5 3926.5 3930.7 3933.4 5247.3 5502.3 5574.3 5587.2 5591.2 5393.3 5404.4 5404.8 5405.9 5418.9 5127.4 5276.7 5351.9 5352.1 5365.8 5251.3 5263.4 5264.9 5307.3 5311.5 5150.9 5211.2 5392.5 5403.4 5425.9 5230.1 5253.1 5286.3 5304.9 5319.9 15:18:48 INFO - PROCESS | 22080 | 15:18:48 INFO - PROCESS | 22080 | [#5] yui.html Cycles:180 Average:13191.24 Median:50435.12 stddev:15672.65 (31.1%) stddev-sans-first:15688.79 15:18:48 INFO - PROCESS | 22080 | Values: 753.2 816.8 817.1 828.5 828.8 11744.3 12762.4 12766.7 12770.2 12789.8 11575.6 11619.2 11641.6 11647.0 11675.5 668.6 857.5 876.0 891.3 892.8 869.1 874.3 875.5 876.8 877.0 922.0 924.3 924.9 925.9 928.8 921.7 925.1 925.1 926.9 929.2 682.8 685.9 687.2 687.8 690.0 12550.9 12566.6 12590.6 12592.3 12608.3 12872.6 12980.9 13048.3 13198.1 13256.0 10473.7 10535.4 10581.6 10636.1 10824.2 3334.5 3366.7 3386.0 3410.4 3422.0 50004.2 50478.7 51827.5 51893.0 51950.5 9503.6 9886.7 10153.4 10191.5 10607.9 19539.3 19680.1 20084.2 20112.8 20131.8 6886.6 7090.5 7137.2 7171.7 7305.0 3807.6 3991.1 3992.8 4037.3 4052.4 3040.7 3137.1 3141.0 3144.6 3169.9 517.5 538.7 549.9 553.8 555.0 585.9 610.5 639.9 640.9 642.6 8028.4 8035.6 8122.7 8345.6 8382.3 562.7 601.0 630.5 642.5 662.7 4066.7 4082.2 4177.6 4194.1 4194.4 58498.4 59359.4 59985.7 60071.7 60684.4 50391.5 50856.5 51319.5 53078.0 53363.5 19365.7 19470.8 21399.9 46812.5 47076.3 7582.5 7742.0 7760.9 7762.0 7908.3 31828.8 32428.0 32640.3 32646.8 33211.5 39464.8 41963.6 43220.6 43320.6 43606.0 10579.0 10791.8 10805.4 10889.7 10900.4 10682.4 10987.3 11308.2 11527.9 12006.7 10343.4 10404.3 10483.3 10640.1 10828.8 9739.0 10048.7 10111.9 10487.4 10857.2 9613.0 9727.1 9753.7 10330.4 10334.4 9238.0 9269.9 9353.6 9379.3 9545.6 8726.5 9292.3 9418.2 9421.5 9543.4 15:18:48 INFO - PROCESS | 22080 | -------- Summary: end -------- 15:18:48 INFO - PROCESS | 22080 | 15:18:49 INFO - TEST-INFO | 22080: exit 0 15:18:49 INFO - TEST-OK | dromaeo_css | took 1117319ms 15:18:49 INFO - TEST-START | kraken 15:18:49 INFO - operating with platform_type : linux_ 15:18:49 INFO - Initialising browser for kraken test... 15:18:49 INFO - TEST-INFO | started process 22316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4DwNNZ/profile http://localhost:58786/getInfo.html) 15:18:53 INFO - PROCESS | 22316 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 15:18:53 INFO - PROCESS | 22316 | 15:18:53 INFO - PROCESS | 22316 | (process:22383): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:18:54 INFO - PROCESS | 22316 | __metrics Screen width/height:1600/1200 15:18:54 INFO - PROCESS | 22316 | colorDepth:24 15:18:54 INFO - PROCESS | 22316 | Browser inner width/height: 1024/697 15:18:54 INFO - PROCESS | 22316 | __metrics 15:18:55 ERROR - PROCESS | 22316 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 15:18:56 INFO - TEST-INFO | 22316: exit 0 15:18:56 INFO - Browser initialized. 15:18:56 INFO - Running cycle 1/1 for kraken test... 15:18:56 INFO - TEST-INFO | started process 22434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4DwNNZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:18:58 INFO - PROCESS | 22434 | 15:18:58 INFO - PROCESS | 22434 | (process:22497): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:19:08 INFO - PROCESS | 22434 | RSS: Main: 164843520 15:19:08 INFO - PROCESS | 22434 | 15:19:11 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:58786/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58786/tests/kraken/driver.html?testName=audio-beat-detection) 15:19:12 INFO - PROCESS | 22434 | RSS: Main: 167948288 15:19:12 INFO - PROCESS | 22434 | 15:19:15 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:58786/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58786/tests/kraken/driver.html?testName=audio-dft) 15:19:15 INFO - PROCESS | 22434 | RSS: Main: 168214528 15:19:15 INFO - PROCESS | 22434 | 15:19:18 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:58786/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58786/tests/kraken/driver.html?testName=audio-fft) 15:19:19 INFO - PROCESS | 22434 | RSS: Main: 164524032 15:19:19 INFO - PROCESS | 22434 | 15:19:21 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:58786/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58786/tests/kraken/driver.html?testName=audio-oscillator) 15:19:22 INFO - PROCESS | 22434 | RSS: Main: 164139008 15:19:22 INFO - PROCESS | 22434 | 15:19:24 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:58786/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58786/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:19:25 INFO - PROCESS | 22434 | RSS: Main: 164659200 15:19:25 INFO - PROCESS | 22434 | 15:19:28 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:58786/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58786/tests/kraken/driver.html?testName=imaging-darkroom) 15:19:28 INFO - PROCESS | 22434 | RSS: Main: 164687872 15:19:28 INFO - PROCESS | 22434 | 15:19:32 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:58786/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58786/tests/kraken/driver.html?testName=imaging-desaturate) 15:19:33 INFO - PROCESS | 22434 | RSS: Main: 162975744 15:19:33 INFO - PROCESS | 22434 | 15:19:36 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:58786/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58786/tests/kraken/driver.html?testName=json-parse-financial) 15:19:36 INFO - PROCESS | 22434 | RSS: Main: 163799040 15:19:36 INFO - PROCESS | 22434 | 15:19:38 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:58786/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58786/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:19:39 INFO - PROCESS | 22434 | RSS: Main: 164323328 15:19:39 INFO - PROCESS | 22434 | 15:19:41 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:58786/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58786/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:19:41 INFO - PROCESS | 22434 | RSS: Main: 165036032 15:19:41 INFO - PROCESS | 22434 | 15:19:44 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:58786/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58786/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:19:44 INFO - PROCESS | 22434 | RSS: Main: 164765696 15:19:44 INFO - PROCESS | 22434 | 15:19:47 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:58786/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:19:48 INFO - PROCESS | 22434 | RSS: Main: 164933632 15:19:48 INFO - PROCESS | 22434 | 15:19:51 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:58786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:19:51 INFO - PROCESS | 22434 | RSS: Main: 164929536 15:19:51 INFO - PROCESS | 22434 | 15:19:53 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:58786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58786/tests/kraken/driver.html?testName=ai-astar) 15:19:53 INFO - PROCESS | 22434 | RSS: Main: 167305216 15:19:53 INFO - PROCESS | 22434 | 15:19:53 INFO - PROCESS | 22434 | __start_tp_report 15:19:53 INFO - PROCESS | 22434 | _x_x_mozilla_page_load 15:19:53 INFO - PROCESS | 22434 | _x_x_mozilla_page_load_details 15:19:53 INFO - PROCESS | 22434 | |i|pagename|runs| 15:19:53 INFO - PROCESS | 22434 | |0;ai-astar;112;114;108;115;115;115;107;114;115;117 15:19:53 INFO - PROCESS | 22434 | |1;audio-beat-detection;163;134;163;208;136;165;159;133;207;135 15:19:53 INFO - PROCESS | 22434 | |2;audio-dft;164;172;179;163;164;162;163;165;165;165 15:19:53 INFO - PROCESS | 22434 | |3;audio-fft;77;77;77;169;75;78;77;77;157;75 15:19:53 INFO - PROCESS | 22434 | |4;audio-oscillator;92;94;171;92;93;94;137;93;94;160 15:19:53 INFO - PROCESS | 22434 | |5;imaging-gaussian-blur;118;118;118;118;118;118;119;119;118;119 15:19:53 INFO - PROCESS | 22434 | |6;imaging-darkroom;148;147;147;148;148;147;148;148;147;148 15:19:53 INFO - PROCESS | 22434 | |7;imaging-desaturate;95;96;95;95;98;95;95;100;100;100 15:19:53 INFO - PROCESS | 22434 | |8;json-parse-financial;64;65;66;64;65;65;67;65;64;65 15:19:53 INFO - PROCESS | 22434 | |9;json-stringify-tinderbox;64;66;65;64;65;64;65;63;64;64 15:19:53 INFO - PROCESS | 22434 | |10;stanford-crypto-aes;82;82;82;82;81;89;87;82;141;83 15:19:53 INFO - PROCESS | 22434 | |11;stanford-crypto-ccm;130;135;139;130;138;136;142;140;154;142 15:19:53 INFO - PROCESS | 22434 | |12;stanford-crypto-pbkdf2;176;171;176;172;170;170;165;179;174;175 15:19:53 INFO - PROCESS | 22434 | |13;stanford-crypto-sha256-iterative;66;68;68;67;71;66;67;69;68;66 15:19:53 INFO - PROCESS | 22434 | __end_tp_report 15:19:53 INFO - PROCESS | 22434 | __start_cc_report 15:19:53 INFO - PROCESS | 22434 | _x_x_mozilla_cycle_collect,947 15:19:53 INFO - PROCESS | 22434 | __end_cc_report 15:19:53 INFO - PROCESS | 22434 | __startTimestamp1463264393860__endTimestamp 15:19:53 INFO - PROCESS | 22434 | 15:19:53 INFO - PROCESS | 22434 | ------- Summary: start ------- 15:19:53 INFO - PROCESS | 22434 | Number of tests: 14 15:19:53 INFO - PROCESS | 22434 | 15:19:53 INFO - PROCESS | 22434 | [#0] ai-astar Cycles:10 Average:113.20 Median:115.00 stddev:3.26 (2.8%) stddev-sans-first:3.43 15:19:53 INFO - PROCESS | 22434 | Values: 112.0 114.0 108.0 115.0 115.0 115.0 107.0 114.0 115.0 117.0 15:19:53 INFO - PROCESS | 22434 | 15:19:53 INFO - PROCESS | 22434 | [#1] audio-beat-detection Cycles:10 Average:160.30 Median:163.00 stddev:28.21 (17.3%) stddev-sans-first:29.90 15:19:53 INFO - PROCESS | 22434 | Values: 163.0 134.0 163.0 208.0 136.0 165.0 159.0 133.0 207.0 135.0 15:19:53 INFO - PROCESS | 22434 | 15:19:53 INFO - PROCESS | 22434 | [#2] audio-dft Cycles:10 Average:166.20 Median:165.00 stddev:5.27 (3.2%) stddev-sans-first:5.53 15:19:53 INFO - PROCESS | 22434 | Values: 164.0 172.0 179.0 163.0 164.0 162.0 163.0 165.0 165.0 165.0 15:19:53 INFO - PROCESS | 22434 | 15:19:53 INFO - PROCESS | 22434 | [#3] audio-fft Cycles:10 Average:93.90 Median:77.00 stddev:36.54 (47.5%) stddev-sans-first:38.24 15:19:53 INFO - PROCESS | 22434 | Values: 77.0 77.0 77.0 169.0 75.0 78.0 77.0 77.0 157.0 75.0 15:19:53 INFO - PROCESS | 22434 | 15:19:53 INFO - PROCESS | 22434 | [#4] audio-oscillator Cycles:10 Average:112.00 Median:93.00 stddev:31.45 (33.8%) stddev-sans-first:32.52 15:19:53 INFO - PROCESS | 22434 | Values: 92.0 94.0 171.0 92.0 93.0 94.0 137.0 93.0 94.0 160.0 15:19:53 INFO - PROCESS | 22434 | 15:19:53 INFO - PROCESS | 22434 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 15:19:53 INFO - PROCESS | 22434 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 119.0 119.0 118.0 119.0 15:19:53 INFO - PROCESS | 22434 | 15:19:53 INFO - PROCESS | 22434 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 15:19:53 INFO - PROCESS | 22434 | Values: 148.0 147.0 147.0 148.0 148.0 147.0 148.0 148.0 147.0 148.0 15:19:53 INFO - PROCESS | 22434 | 15:19:53 INFO - PROCESS | 22434 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:95.00 stddev:2.33 (2.5%) stddev-sans-first:2.37 15:19:53 INFO - PROCESS | 22434 | Values: 95.0 96.0 95.0 95.0 98.0 95.0 95.0 100.0 100.0 100.0 15:19:53 INFO - PROCESS | 22434 | 15:19:53 INFO - PROCESS | 22434 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 15:19:53 INFO - PROCESS | 22434 | Values: 64.0 65.0 66.0 64.0 65.0 65.0 67.0 65.0 64.0 65.0 15:19:53 INFO - PROCESS | 22434 | 15:19:53 INFO - PROCESS | 22434 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 15:19:53 INFO - PROCESS | 22434 | Values: 64.0 66.0 65.0 64.0 65.0 64.0 65.0 63.0 64.0 64.0 15:19:53 INFO - PROCESS | 22434 | 15:19:53 INFO - PROCESS | 22434 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:82.00 stddev:18.42 (22.5%) stddev-sans-first:19.35 15:19:53 INFO - PROCESS | 22434 | Values: 82.0 82.0 82.0 82.0 81.0 89.0 87.0 82.0 141.0 83.0 15:19:53 INFO - PROCESS | 22434 | 15:19:53 INFO - PROCESS | 22434 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:139.50 stddev:6.92 (5.0%) stddev-sans-first:6.60 15:19:53 INFO - PROCESS | 22434 | Values: 130.0 135.0 139.0 130.0 138.0 136.0 142.0 140.0 154.0 142.0 15:19:53 INFO - PROCESS | 22434 | 15:19:53 INFO - PROCESS | 22434 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:174.50 stddev:4.02 (2.3%) stddev-sans-first:4.10 15:19:53 INFO - PROCESS | 22434 | Values: 176.0 171.0 176.0 172.0 170.0 170.0 165.0 179.0 174.0 175.0 15:19:53 INFO - PROCESS | 22434 | 15:19:53 INFO - PROCESS | 22434 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.58 (2.3%) stddev-sans-first:1.56 15:19:53 INFO - PROCESS | 22434 | Values: 66.0 68.0 68.0 67.0 71.0 66.0 67.0 69.0 68.0 66.0 15:19:53 INFO - PROCESS | 22434 | -------- Summary: end -------- 15:19:53 INFO - PROCESS | 22434 | 15:19:54 INFO - TEST-INFO | 22434: exit 0 15:19:54 INFO - TEST-OK | kraken | took 65387ms 15:19:54 INFO - SUITE-END | took 1182s 15:19:55 INFO - Completed test suite (00:19:42) 15:19:55 INFO - javascript benchmark 15:19:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6523.051934340836, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2712.416830381468, 2758.6827514835786, 2768.6539182602173, 2771.0439898235104, 2771.847548384838, 4802.639802014845, 4879.658423910323, 4935.555799978001, 4947.0, 4997.350344455225, 4806.3030860525205, 4849.321095046696, 4871.5615594596475, 4911.435184953732, 4929.260610908356, 4452.109578084396, 4485.730856148625, 4558.156741002908, 4573.5197804230575, 4596.816127354902, 4541.023679908819, 4591.517890621487, 4635.605973492257, 4665.3235280884255, 4692.178868697982, 4433.002574420761, 4551.635869130461, 4624.583787459145, 4628.768561571925, 4701.529847015306, 4569.086182763461, 4572.908541829145, 4580.725156490621, 4614.746188959606, 4617.307403889444, 4553.817847286105, 4554.954450455486, 4561.315802629599, 4571.634269258485, 4602.631789456836, 4683.812647494096, 4759.714417134983, 4782.880427989328, 4819.734914579697, 4823.493533179001, 5149.0731668299695, 5163.7159956202395, 5196.090684130299, 5220.216967454874, 5226.491284183575, 5250.0, 5253.658512196695, 5260.789568417259, 5301.7084060376665, 5312.9734351328, 4920.384951881015, 4949.381327334083, 4960.578350840146, 4965.90068198634, 4967.503249675004, 5380.5630520728655, 5423.0, 5435.891282174334, 5440.265564148789, 5490.505854473116, 5072.492750724898, 5213.0, 5215.687058776485, 5225.399079105951, 5228.764705588258, 5298.788048478094, 5331.786728530893, 5337.893242135213, 5369.677819330853, 5398.460153984649, 5241.213817927342, 5277.340332458442, 5284.180951952453, 5287.656302340412, 5331.520163185254, 5054.4692807254705, 5090.9236361454605, 5202.297689811902, 5255.500727430888, 5279.788808447619, 4319.719218250803, 4421.314696222091, 4422.270325396338, 4454.643628509712, 4476.400555691109, 3883.3204189266767, 3897.668698160688, 3899.805009749501, 3926.1362500249897, 3973.5033120859894, 4547.136044151667, 4637.721736695809, 4653.2554791233915, 4660.231061874752, 4707.082118986833, 5264.31563896691, 5292.470752924677, 5311.814086506954, 5320.574354051667, 5363.651362661414, 4600.72395656255, 4614.7000444971645, 4622.329762184464, 4644.419447569054, 4654.650901182425, 4640.095181439587, 4723.7874295656775, 4735.976320118378, 4744.074905393484, 4783.473817880031, 4902.1911384621135, 4924.4583095859425, 4941.678790878582, 4957.553820156059, 4958.206686930218, 5274.868128296824, 5276.947230527646, 5280.920786188133, 5295.555444704913, 5338.706371149624, 4893.363862697826, 4979.4024717032735, 4983.25251212321, 4983.3023376728015, 5028.597712182944, 5222.503862133243, 5278.234655974786, 5302.045631786161, 5307.363116426053, 5341.5459685927135, 5335.38643056038, 5364.892702145858, 5366.034113859387, 5374.193870919394, 5446.291982042309, 4970.801167953241, 5084.618653600921, 5103.209002604603, 5182.689038657692, 5217.113090774502, 5103.055934652101, 5126.641135120655, 5155.200943853709, 5162.354705661793, 5201.453847346125, 5041.873953151201, 5055.216441451581, 5081.339425874613, 5089.720065396439, 5159.355080614923, 4999.675021123615, 5201.92197117036, 5230.34620672416, 5261.36863576358, 5275.525202731773, 4910.582600479, 5057.747112644427, 5080.339555857715, 5087.847364579068, 5122.180451127951], "value": 4851.678663784666, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.9945400545996, 596.3946594206881, 601.2934801608111, 611.1199872184054, 629.8047605242378, 39927.60072399275, 40950.59049409505, 40987.0, 41016.58983410165, 41153.38269925946, 40921.0, 41680.58319416805, 41715.37426938598, 41763.16473670525, 41793.0, 7937.365010799137, 8043.436959412844, 8056.39577031722, 8059.395545334094, 8061.879071813927, 7798.0, 7945.483543569679, 7990.560519171443, 8041.155678653745, 8070.112287648383, 8009.879851802228, 8025.879611805827, 8032.678692852279, 8060.3954703397185, 8068.7175948841805, 8031.95984020082, 8041.798955026142, 8058.274755271995, 8059.597020148969, 8078.232567906099, 7989.201079891965, 8021.398395120331, 8022.839543209103, 8056.959715201387, 8063.1130575636635, 32707.18232044194, 38351.80824095861, 38396.23207535862, 38777.61222387768, 38896.611033889865, 3200.9199770005703, 3289.5723555937816, 3323.3353329333986, 3393.7115345195443, 3396.6603339666085, 27972.300692482648, 28538.0, 28927.132186034454, 29535.70464295351, 29542.409151816842, 3455.8963231103107, 3470.6182319944787, 3511.3855075361967, 3515.5781306243157, 3643.2895585360866, 235199.0, 235306.0, 236261.81869090715, 236626.0, 236876.0, 33877.32245355079, 34090.31819363599, 34452.0, 35372.29255414929, 35741.46387804185, 36727.632723672956, 37128.62871371306, 37437.251254975294, 37497.0, 37528.24943501169, 14660.120392776467, 14912.254387280593, 14920.850791491946, 14923.70152596942, 14938.103713777207, 12262.81605775914, 12285.877141228651, 12314.568990085305, 12389.256644601353, 12400.13199076056, 8507.404481686222, 8518.403711740242, 8553.82892342162, 8610.741677749678, 8664.176903194186, 3262.1029216965526, 3306.2560923791953, 3341.548890899697, 3385.830708464567, 3398.5242066110764, 969.0, 983.9458829764432, 1037.7094413564064, 1043.5773511727762, 1046.6493724602192, 29360.412791744046, 29403.0, 29882.0, 30051.248718781768, 30132.246693832392, 1039.2465462539749, 1066.2962444786403, 1068.8450174724621, 1085.3216739537788, 1090.7491277006334, 15440.768388474182, 15911.363545458284, 16041.598960026093, 16135.273912673958, 16152.35390584387, 393514.032429836, 394117.0, 395059.0, 398848.0, 399180.0, 50834.0, 50851.74574127106, 51541.0, 51743.0, 51759.0, 1278.341654048166, 1296.4230917241925, 1297.3383574377135, 1324.9933750331186, 1329.534662868008, 27688.861555692092, 29173.41653166967, 29308.85345573344, 29379.265518362212, 29657.0, 45429.77285113553, 48842.75578622084, 51039.74480127576, 51154.0, 56064.0, 363059.0, 366269.0, 368494.0, 370739.0, 372603.0, 40688.38967415432, 40839.18321633491, 41315.0, 41400.1719965605, 41500.79249603733, 44742.0, 44871.0, 44931.55068449274, 45347.54652453433, 45359.7732011351, 38128.26163742309, 38892.2221555573, 39473.60526394814, 40177.39733903935, 40231.0, 38098.18987107581, 38619.42070868883, 39297.0, 39736.403953940135, 40135.1972960545, 32856.34287314288, 37709.0, 37925.62074379331, 38468.807655961544, 38695.0, 33185.0, 33493.33013339671, 35100.297994040484, 35365.46951795777, 37932.0, 26399.868000659873, 26926.0, 27072.458550829266, 27094.0, 27257.591136132578], "value": 17451.68767537451, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.6192938026662, 383.4593223554787, 386.57669851512594, 396.298551563732, 399.75015615240477, 15378.307976141072, 17359.82640173598, 18054.45836624902, 18088.819111808876, 18139.093045347712, 16763.497095087136, 16810.579735506617, 17518.386856460027, 17822.554436139104, 17955.0, 4875.366202393693, 4998.050370429625, 5026.195808670614, 5043.924341134886, 5046.318746969149, 3675.246574452244, 5687.800926967557, 6009.038553831388, 6023.18686977259, 6083.422074902899, 5176.637635365526, 6052.0, 6055.303640081381, 6075.665838378887, 6079.483243924272, 5428.375736790261, 5527.198556209327, 5552.4169962154, 5552.86117847053, 5570.136628822519, 5156.355455568054, 5503.3120859892515, 5507.669539827623, 5544.223808666749, 5549.19536667185, 12650.683732906751, 12798.48806047757, 12923.612291631267, 18435.446936591925, 19813.60372792536, 1892.4417296897448, 1910.866239363245, 1951.7853036166011, 2064.6283668939586, 2101.9941483678335, 9210.631574737003, 9240.26077913772, 9262.814743705088, 9626.229901607925, 9871.40771553709, 1738.869734672473, 1739.8434140927377, 1771.5659663382553, 1771.7342398640178, 1818.7453756474104, 71643.91396245183, 74463.62768186179, 74509.0, 74988.62505687491, 76249.0, 9780.951095244478, 10175.949120254352, 10260.794784104277, 10413.9479302603, 10438.37369757817, 14328.49850255257, 14452.855471445362, 14474.927625362016, 14487.20320382368, 14532.564023079325, 7454.701811927463, 7546.811329716801, 7575.106223444139, 7628.199039100926, 7642.235776422313, 7148.821279468055, 7156.463265255023, 7219.783406497813, 7233.8553228935125, 7374.668139933716, 4355.455568053993, 4388.078503514298, 4414.55854414556, 4442.42248507692, 4503.549645035536, 1723.3106757297182, 1744.4243399678076, 1850.981490185081, 1888.1125870840683, 1914.8276655101108, 793.3217099379947, 833.2251006563954, 853.2747164909777, 882.188386684252, 905.7373361725026, 16144.192790360436, 16649.750253746202, 17085.914570427067, 17192.656146876994, 17236.913815430842, 909.1045320359441, 910.9180173784391, 920.3235621817959, 980.8038392321564, 1007.4861820471613, 8147.592620368958, 9718.562664680107, 9749.805003899883, 9761.170300524534, 9957.651482198233, 380916.0, 381293.0, 391588.0, 395146.0, 395812.0, 79002.0, 80849.59575202086, 81247.50019998386, 81263.0, 81901.0, 932.2774849491562, 978.7944531648291, 985.2952897106929, 990.7615480649189, 992.7468495533593, 16184.514464566082, 16215.35138594443, 16246.431374902295, 16710.663146947973, 16745.497635070966, 37106.628933710315, 37369.0, 38001.42997854979, 39105.0, 39649.2070158601, 54018.0, 54562.727186363816, 55317.0, 55935.0, 56027.43972560222, 7829.099653539915, 7877.369810415267, 7953.642086106023, 7966.800829979297, 8038.517688938682, 9885.258605604464, 11773.470193841127, 11939.940300298444, 12057.492813398325, 12111.757764844477, 9979.20166386702, 10133.64532241368, 10140.49297535135, 10384.480775961021, 10614.787704245717, 10258.948705256425, 10263.23025773055, 10351.43067131315, 10474.476276186313, 10687.358758474516, 5838.883222335445, 10191.439470828878, 10450.68647940563, 10504.789904202025, 10696.716394032766, 7625.847483050419, 7716.729914452967, 7799.49303295284, 7940.761777146695, 7983.640736167003, 8477.448965817202, 9921.950390248003, 9938.652147174815, 9964.451955142536, 10049.447280399649], "value": 8326.830493585547, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1540.9537713868585, 1583.0976343484215, 1747.9563010924726, 1910.3791267837955, 1915.9521011974691, 7363.6318184090715, 8007.359411247101, 8112.0, 8565.914340856589, 8593.226609605133, 8114.066882308536, 8332.250097491225, 8414.116517765638, 8442.282405995498, 8452.746417607466, 2273.113485740558, 2289.7595752446005, 2312.387217387394, 2317.0, 2329.37106981115, 2134.4877229464896, 2202.427368884086, 2309.0763694522243, 2326.8371214015024, 2328.441174118208, 2279.87460689662, 2280.395695140781, 2287.5653625811124, 2331.2889568681544, 2346.741858395575, 2219.1456289328644, 2254.3913143451177, 2264.9660255096187, 2267.353804165805, 2268.7504374518708, 2211.1929145861804, 2235.68700381945, 2237.2281562860785, 2242.529068895534, 2248.2468373095035, 8356.164383561596, 8396.412251142423, 8445.662173513052, 8455.239028487404, 8469.0, 4832.637552183565, 4928.950710492885, 4948.0, 4971.37857767779, 4996.25056241563, 2975.345424006715, 3003.8648260828095, 3199.63204231514, 3205.0, 3217.436948533997, 955.159459675488, 955.6702937486556, 961.1349785193312, 978.774881777188, 989.2432289298692, 11636.941815291038, 11647.6505704829, 11666.300021998622, 11698.94150529242, 11728.648140555712, 4338.197433474817, 4373.759443230653, 4386.583274588909, 4457.064016556559, 4459.44256967879, 9815.214782817358, 9832.852507212398, 9845.655402060893, 9900.702978910644, 9953.701388958198, 4934.1118598651865, 5004.949950500449, 5007.248912663057, 5012.674176178537, 5052.8484145475695, 3962.5244970603135, 4308.74147551148, 4448.399466072039, 4541.091781643684, 4566.13243483737, 3876.573576906538, 3915.7454765440157, 4031.697622678311, 4092.01791570027, 4116.341385378325, 1240.8076748104058, 1281.0, 1290.7224946636518, 1298.2859427314938, 1301.3168086754529, 850.4132148817296, 860.2945584620676, 877.9736607901773, 914.1178762494225, 931.0642803981955, 5455.863603409946, 5514.724263786795, 5528.695921724263, 5608.298962629671, 5747.540196784247, 896.7758060484879, 910.6220918318955, 923.1645360948219, 952.1620973543238, 993.4933184076173, 3836.0793409582056, 3852.2488114817343, 3853.537575490959, 3874.1283211277237, 3934.1934903344745, 9759.9024009759, 10104.494775261208, 10139.239557033252, 10166.949165254126, 10179.796404071878, 10036.197104231644, 10058.145057670034, 10062.24533160016, 10063.094321511098, 10077.748056298504, 7123.180834204133, 7180.246074162243, 7210.783676489714, 7231.204567497571, 7236.710531578783, 5388.326459192601, 5399.83800485986, 5462.317210348707, 5471.5896307777875, 5664.461876121762, 8939.0, 9221.953890230507, 9277.072292770668, 9446.905530944603, 9483.810323793623, 9390.295727820578, 9500.42997420157, 9563.330566860253, 9618.230541556519, 9687.806243875224, 7874.763757087297, 7983.081945576101, 7983.441159119038, 8029.237222463857, 8044.6379912902885, 7905.920940790518, 7932.325752310888, 7941.444098913252, 7943.0, 8100.189981001853, 7007.789766307019, 7223.1693355264815, 7255.383292420203, 7267.273272672902, 7357.963210183915, 7122.7507037253445, 7280.453965952469, 7287.817804554928, 7314.158871729819, 7432.516886402366, 6876.071730316543, 6946.548474349152, 6972.058772065706, 7046.823829404306, 7046.823829404306, 4701.670883038291, 4803.18345881208, 4873.95126048735, 4914.92627610579, 5051.747412629427, 4795.352627395257, 4926.433460152129, 4959.256111583291, 5032.245163225545, 5066.847994560169], "value": 4427.425294161902, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.34723123135103, 320.37047202247584, 320.5384246684774, 324.8456982933107, 324.9382617302714, 5019.723915184668, 5062.190049592066, 5074.107758577612, 5074.670146440479, 5089.7679973217, 4994.97502512487, 5007.899842003158, 5016.247562865572, 5018.899622007567, 5072.416672082712, 3861.903452413684, 3894.6689531389866, 3929.0766669832565, 3934.8229329680235, 3958.2083583283315, 3943.2704949584418, 3952.584978577251, 3970.642642162219, 3977.125032492847, 3995.4805875236325, 3939.6848252139903, 3948.4669569608022, 3957.76253424794, 3968.2063587282514, 3971.3844354125013, 3781.640744129303, 3923.3914095221107, 3938.7439816411843, 3967.821448034845, 3979.721419500622, 3486.721062315034, 3500.387432199355, 3501.28223714138, 3505.737069719781, 3518.7888726676483, 4729.290606409032, 4737.194676904935, 4743.525647435264, 4751.85955370712, 4759.714417134983, 4342.413774140482, 4444.644428445717, 4488.798004089824, 4508.549145085498, 4515.729056256602, 5141.30592370029, 5179.559737422323, 5188.11801993662, 5211.557017653504, 5216.295800067019, 3825.6365645263654, 3832.1569254764186, 3840.906705845293, 3853.497136116917, 3870.909708757296, 5462.918056229159, 5495.313085864267, 5516.834494965117, 5526.982651332275, 5532.0488163094205, 3673.8897833065053, 3878.941815872764, 3882.320593896057, 3884.3590807516443, 3900.64894159527, 3918.294706952719, 3955.723099383016, 3956.802159891994, 3970.900727481836, 3981.900452488653, 4497.572730590588, 4505.481869584974, 4508.81964721414, 4509.481409637868, 4548.636109111263, 5108.795648174106, 5362.222477740784, 5368.32895888014, 5374.220737992969, 5374.27447294618, 1373.5192682561024, 1382.315753701924, 1383.0, 1388.8403183342023, 1390.9513167039106, 845.5307304445969, 865.8528050231475, 876.4784952952983, 878.493383846706, 893.8614514750224, 4584.968382114064, 4747.572718455355, 4755.904881902343, 4818.6626936114135, 4823.324734537167, 5497.367802702661, 5526.861828454241, 5540.252065971123, 5547.889042219133, 5579.525740312119, 4471.888202794891, 4708.293755936637, 4732.810687572527, 4761.52384761528, 4778.474367819537, 2911.3696330054813, 2959.8816047358296, 2967.1840243933093, 2968.554716792455, 2973.747231485305, 5236.0, 5257.845292824351, 5266.1574148136115, 5270.183121616155, 5298.178782288752, 5391.838244852583, 5675.2054712340305, 5689.77240910359, 5701.372848986608, 5702.830919661459, 5244.632875698664, 5246.685198888079, 5247.580193584427, 5269.104252277199, 5272.762725677354, 5592.804251851166, 5607.775688972559, 5620.044592419216, 5620.943790562042, 5636.957162924872, 5165.845024649267, 5383.246345511553, 5423.7830486780085, 5458.707342915905, 5496.450354964471, 5209.984053109607, 5249.763760630704, 5257.684538927677, 5261.0, 5262.526372626482, 3869.941950870683, 3909.452676625218, 3926.489556357655, 3930.744501607386, 3933.370660694275, 5247.317848679647, 5502.266785962409, 5574.275344205227, 5587.245721827501, 5591.18927755465, 5393.325834270716, 5404.378496472956, 5404.8108316208745, 5405.891702236052, 5418.864528386822, 5127.4103478099005, 5276.736163191902, 5351.892962140813, 5352.090144675492, 5365.758540865592, 5251.291075704731, 5263.421023687315, 5264.921026184534, 5307.256984022317, 5311.521963023347, 5150.896982060262, 5211.244369566316, 5392.541633961, 5403.378611459732, 5425.891482170414, 5230.110881150137, 5253.054450199001, 5286.286351342674, 5304.867378315573, 5319.893602127859], "value": 4023.4579860450244, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.1715113375286, 816.816216351321, 817.1052697296458, 828.5318794880893, 828.7886588919824, 11744.295342279458, 12762.361881905914, 12766.744665106693, 12770.233785972836, 12789.808152877702, 11575.594854180106, 11619.186656934018, 11641.592544260953, 11647.0, 11675.474603642835, 668.6489592963709, 857.5412154497345, 875.9868601970976, 891.3092353426082, 892.7768057985504, 869.0744357259498, 874.2961915657893, 875.4878396138234, 876.7895705030778, 876.9693060742875, 922.0088404964656, 924.2513564013137, 924.8936372317169, 925.8981512033705, 928.8281667891462, 921.6543796076471, 925.051821882569, 925.1442415765424, 926.8980412154658, 929.1823195587907, 682.7917485167022, 685.859398823245, 687.1925487552106, 687.7936619014275, 690.0408432279136, 12550.874491255061, 12566.560170394083, 12590.622281331574, 12592.307423091726, 12608.306543140123, 12872.613821585368, 12980.870191298061, 13048.34758262083, 13198.142120762215, 13256.0, 10473.738156546071, 10535.420551869644, 10581.576736930514, 10636.149108071335, 10824.18818588609, 3334.4664853623303, 3366.6969972702327, 3385.9661403386144, 3410.4202285611505, 3422.0076177908627, 50004.249936250984, 50478.7476062621, 51827.481725182646, 51892.96214075735, 51950.48049519494, 9503.619855205714, 9886.653967111117, 10153.393737084602, 10191.474687532544, 10607.94696026515, 19539.316123935594, 19680.114394852266, 20084.19663213455, 20112.798872011386, 20131.79868201299, 6886.586804791728, 7090.503664743418, 7137.2149063602965, 7171.677274522659, 7304.963475182696, 3807.638274363931, 3991.1219531702977, 3992.760434373889, 4037.253108174997, 4052.4124002019544, 3040.650325212629, 3137.074563003919, 3140.979181765935, 3144.622645282581, 3169.904902852918, 517.5368045599167, 538.7360193505154, 549.9175123731472, 553.8255449533384, 554.9972250138724, 585.8652509922656, 610.4963405190736, 639.9456046236029, 640.8654182621608, 642.645391058673, 8028.357731381476, 8035.55804430762, 8122.715704950417, 8345.628645271092, 8382.287505561973, 562.7270773674765, 600.9579329446897, 630.4609558827136, 642.4824088117612, 662.6752891083335, 4066.6543343815515, 4082.1631565528996, 4177.624013838769, 4194.0563373240775, 4194.412782210493, 58498.41501585015, 59359.40640593625, 59985.700071500236, 60071.69964150239, 60684.393156068756, 50391.49608503941, 50856.49143508592, 51319.48680513222, 53078.0, 53363.46636533585, 19365.709514357015, 19470.80529194718, 21399.89300053521, 46812.53187468082, 47076.293855592194, 7582.507137036075, 7741.961290193513, 7760.860008792038, 7761.9611901940125, 7908.288254057163, 31828.840855795574, 32428.0, 32640.34719305648, 32646.83676581602, 33211.50182747309, 39464.80267598644, 41963.580364195965, 43220.56779432166, 43320.56679433165, 43606.0, 10579.0, 10791.838122428328, 10805.405702686428, 10889.727756806144, 10900.400477973788, 10682.412467314372, 10987.340759554452, 11308.151888608223, 11527.942360288145, 12006.699832504257, 10343.37939723619, 10404.271700980858, 10483.266171367932, 10640.148788097089, 10828.783424331312, 9739.026097390488, 10048.69853904384, 10111.898881011095, 10487.37075775456, 10857.239993200401, 9612.951935240279, 9727.07592778685, 9753.707388778348, 10330.431826249629, 10334.379937203792, 9237.983821779733, 9269.907300926905, 9353.579088940878, 9379.343445958717, 9545.570449329936, 8726.476411415335, 9292.256619470561, 9418.152366287068, 9421.5396613525, 9543.379680320757], "value": 6133.398839851293, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1605.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 108.0, 115.0, 115.0, 115.0, 107.0, 114.0, 115.0, 117.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 134.0, 163.0, 208.0, 136.0, 165.0, 159.0, 133.0, 207.0, 135.0], "value": 160.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 172.0, 179.0, 163.0, 164.0, 162.0, 163.0, 165.0, 165.0, 165.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 169.0, 75.0, 78.0, 77.0, 77.0, 157.0, 75.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 171.0, 92.0, 93.0, 94.0, 137.0, 93.0, 94.0, 160.0], "value": 112.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 119.0, 118.0, 119.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 148.0, 147.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 98.0, 95.0, 95.0, 100.0, 100.0, 100.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 64.0, 65.0, 65.0, 67.0, 65.0, 64.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 64.0, 65.0, 64.0, 65.0, 63.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 82.0, 81.0, 89.0, 87.0, 82.0, 141.0, 83.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 135.0, 139.0, 130.0, 138.0, 136.0, 142.0, 140.0, 154.0, 142.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 171.0, 176.0, 172.0, 170.0, 170.0, 165.0, 179.0, 174.0, 175.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 67.0, 71.0, 66.0, 67.0, 69.0, 68.0, 66.0], "value": 67.6, "unit": "score"}]}]} 15:19:55 INFO - Return code: 0 15:19:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:19:55 ERROR - # TBPL SUCCESS # 15:19:55 INFO - Running post-action listener: _resource_record_post_action 15:19:55 INFO - ##### 15:19:55 INFO - ##### Finished run-tests step (success) 15:19:55 INFO - ##### 15:19:55 INFO - Running post-run listener: _resource_record_post_run 15:19:55 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 530722816; Read time: 0; Write time: 538856 15:19:55 INFO - TinderboxPrint: CPU usage
13.4% 15:19:55 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:19:55 INFO - TinderboxPrint: I/O write bytes / time
530,722,816 / 538,856 15:19:55 INFO - TinderboxPrint: CPU idle
8,285.9 (86.5%) 15:19:55 INFO - TinderboxPrint: CPU user
1,231.5 (12.9%) 15:19:55 INFO - TinderboxPrint: Swap in / out
0 / 0 15:19:55 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 242700288; Read time: 0; Write time: 273852 15:19:55 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288022528; Read time: 0; Write time: 265004 15:19:55 INFO - Running post-run listener: _upload_blobber_files 15:19:55 INFO - Blob upload gear active. 15:19:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:19:55 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 15:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:19:56 INFO - (blobuploader) - INFO - Open directory for files ... 15:19:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:19:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:19:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:56 INFO - (blobuploader) - INFO - Done attempting. 15:19:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:19:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:20:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:20:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:20:00 INFO - (blobuploader) - INFO - Done attempting. 15:20:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:20:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:20:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:20:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:20:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:20:01 INFO - (blobuploader) - INFO - Done attempting. 15:20:01 INFO - (blobuploader) - INFO - Iteration through files over. 15:20:01 INFO - Return code: 0 15:20:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:20:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:20:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1b4c9ec3b4831fa84ba8e24afee05a6df2e5946c2d5bfd516d1b279eb015883a4d35f7e9abaa682cca9e69ef3dbfdda99bd704f6b04849c6dc7d92c156676f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/caf9c7bb85192ad351fdd982bfa2ae31375083ab1115273079fb317becdb273d7250675b2ef55bc7d80cd2f8a5e278199fe5ccf37ac902029c7b402b6c19fd70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d12202f2babcc512ba341c0ee1d00f8ee85c9a17b80bdde7b130faf112470b8b0f9f106c53f8b3de8d1b591f3769a781e64fd2b9b35030c96020f714a2f0753a"} 15:20:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:20:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:20:01 INFO - Contents: 15:20:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1b4c9ec3b4831fa84ba8e24afee05a6df2e5946c2d5bfd516d1b279eb015883a4d35f7e9abaa682cca9e69ef3dbfdda99bd704f6b04849c6dc7d92c156676f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/caf9c7bb85192ad351fdd982bfa2ae31375083ab1115273079fb317becdb273d7250675b2ef55bc7d80cd2f8a5e278199fe5ccf37ac902029c7b402b6c19fd70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d12202f2babcc512ba341c0ee1d00f8ee85c9a17b80bdde7b130faf112470b8b0f9f106c53f8b3de8d1b591f3769a781e64fd2b9b35030c96020f714a2f0753a"} 15:20:01 INFO - Running post-run listener: copy_logs_to_upload_dir 15:20:01 INFO - Copying logs to upload dir... 15:20:01 INFO - mkdir: /builds/slave/test/build/upload/logs 15:20:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.631380 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-14 15:19:58.944768) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 15:19:58.948199) ========= 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=52faae308a556c440401f8e5000001e8-1463263159.334392-127088963 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-Non-PGO/sha512/a1b4c9ec3b4831fa84ba8e24afee05a6df2e5946c2d5bfd516d1b279eb015883a4d35f7e9abaa682cca9e69ef3dbfdda99bd704f6b04849c6dc7d92c156676f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/caf9c7bb85192ad351fdd982bfa2ae31375083ab1115273079fb317becdb273d7250675b2ef55bc7d80cd2f8a5e278199fe5ccf37ac902029c7b402b6c19fd70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d12202f2babcc512ba341c0ee1d00f8ee85c9a17b80bdde7b130faf112470b8b0f9f106c53f8b3de8d1b591f3769a781e64fd2b9b35030c96020f714a2f0753a"} build_url:https://queue.taskcluster.net/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011464 build_url: 'https://queue.taskcluster.net/v1/task/bHx3Gp8FTECJ1mAqUok-_A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1b4c9ec3b4831fa84ba8e24afee05a6df2e5946c2d5bfd516d1b279eb015883a4d35f7e9abaa682cca9e69ef3dbfdda99bd704f6b04849c6dc7d92c156676f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/caf9c7bb85192ad351fdd982bfa2ae31375083ab1115273079fb317becdb273d7250675b2ef55bc7d80cd2f8a5e278199fe5ccf37ac902029c7b402b6c19fd70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d12202f2babcc512ba341c0ee1d00f8ee85c9a17b80bdde7b130faf112470b8b0f9f106c53f8b3de8d1b591f3769a781e64fd2b9b35030c96020f714a2f0753a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 15:19:58.976267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 15:19:58.976821) ========= 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=52faae308a556c440401f8e5000001e8-1463263159.334392-127088963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 15:19:59.059978) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 15:19:59.060513) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 15:19:59.060974) ========= ========= Total master_lag: 0.17 =========